-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-05-07 16:12:52 CEST. -- May 07 16:11:00 volumio volumio[1020]: info: Executing endpoint tc_getconfig May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 07 16:11:00 volumio vtcs[1652]: STARTING TidalConnect services, version: 1.4.0.34 May 07 16:11:00 volumio vtcs[1652]: STARTED TidalConnect services. May 07 16:11:00 volumio volumio[1020]: info: Executing endpoint tc_connect May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 07 16:11:00 volumio volumio[1020]: info: Connecting to TidalConnect May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:00 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:11:00 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:11:00 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:11:00 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:11:00 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:00 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received tidalconnect May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:00 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:11:00 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:00 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:11:00 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:11:00 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:11:00 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:00 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received tidalconnect May 07 16:11:00 volumio sudo[1671]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 07 16:11:00 volumio sudo[1671]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 16:11:00 volumio volumiobt[1637]: pulseaudio: no process found May 07 16:11:00 volumio sudo[1671]: pam_unix(sudo:session): session closed for user root May 07 16:11:00 volumio dbus-daemon[668]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.33' (uid=1000 pid=1675 comm="/usr/bin/pulseaudio --high-priority=true ") May 07 16:11:00 volumio systemd[1]: Starting RealtimeKit Scheduling Policy Service... May 07 16:11:00 volumio volumio[1020]: ------------------------------------ BT MESSAGE: BT STATUS: running May 07 16:11:00 volumio dbus-daemon[668]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' May 07 16:11:00 volumio rtkit-daemon[1676]: Successfully called chroot. May 07 16:11:00 volumio rtkit-daemon[1676]: Successfully dropped privileges. May 07 16:11:00 volumio systemd[1]: Started RealtimeKit Scheduling Policy Service. May 07 16:11:00 volumio rtkit-daemon[1676]: Successfully limited resources. May 07 16:11:00 volumio rtkit-daemon[1676]: Running. May 07 16:11:00 volumio rtkit-daemon[1676]: Canary thread running. May 07 16:11:00 volumio rtkit-daemon[1676]: Watchdog thread running. May 07 16:11:00 volumio dbus-daemon[668]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.34' (uid=0 pid=1676 comm="/usr/lib/rtkit/rtkit-daemon ") May 07 16:11:00 volumio systemd[1]: Starting Authorization Manager... May 07 16:11:00 volumio volumio[1020]: ------------------------------------ BT MESSAGE: BT STATUS: running May 07 16:11:00 volumio polkitd[1679]: started daemon version 0.105 using authority implementation `local' version `0.105' May 07 16:11:00 volumio dbus-daemon[668]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 07 16:11:00 volumio systemd[1]: Started Authorization Manager. May 07 16:11:01 volumio pulseaudio[1675]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 07 16:11:01 volumio pulseaudio[1675]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 07 16:11:01 volumio volumiobt[1637]: Applying permissions May 07 16:11:01 volumio volumiobt[1637]: Setting BT discoverable and pairable May 07 16:11:01 volumio bluetoothd[836]: Endpoint registered: sender=:1.54 path=/MediaEndpoint/A2DPSource May 07 16:11:01 volumio bluetoothd[836]: Endpoint registered: sender=:1.54 path=/MediaEndpoint/A2DPSink May 07 16:11:01 volumio pulseaudio[1675]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files May 07 16:11:01 volumio kernel: Bluetooth: RFCOMM TTY layer initialized May 07 16:11:01 volumio kernel: Bluetooth: RFCOMM socket layer initialized May 07 16:11:01 volumio kernel: Bluetooth: RFCOMM ver 1.11 May 07 16:11:01 volumio volumiobt[1637]: Agent registered May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# -e power on May 07 16:11:01 volumio volumiobt[1637]: Invalid command in menu main: -e May 07 16:11:01 volumio volumiobt[1637]: May 07 16:11:01 volumio volumiobt[1637]: Use "help" for a list of available commands in a menu. May 07 16:11:01 volumio volumiobt[1637]: Use "menu " if you want to enter any submenu. May 07 16:11:01 volumio volumiobt[1637]: Use "back" if you want to return to menu main. May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# agent on May 07 16:11:01 volumio volumiobt[1637]: Agent is already registered May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# discoverable on May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# pairable on May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# agent NoInputNoOutput May 07 16:11:01 volumio volumiobt[1637]: Agent is already registered May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# default-agent May 07 16:11:01 volumio volumiobt[1637]: [bluetooth]# quit May 07 16:11:01 volumio volumiobt[1637]: [59B blob data] May 07 16:11:01 volumio volumio[1020]: info: MRS: Getting audio outputs on start May 07 16:11:01 volumio volumio[1020]: info: MRS: Requesting all other devices output May 07 16:11:02 volumio volumio[1020]: info: TidalConnect service started! May 07 16:11:02 volumio volumio[1020]: info: BOOT COMPLETED May 07 16:11:02 volumio volumio[1020]: [Metrics] CommandRouter: 62s 622.49ms May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumiosetStartupVolume May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::Close All Modals sent May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::Close All Modals sent May 07 16:11:02 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.86.46 from 192.168.86.20 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/124.0.0.0 Safari/537.36 Total Clients: 11 May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:02 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:02 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 16:11:02 volumio volumio[1020]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 07 16:11:02 volumio volumio[1020]: info: Received Get System Info May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:11:02 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:02 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:11:02 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:02 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:02 volumio volumio[1020]: info: Listing playlists May 07 16:11:03 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 16:11:03 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 07 16:11:03 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 16:11:03 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 07 16:11:05 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.86.46 from 192.168.86.62 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.4.1 Mobile/15E148 Safari/604.1 Total Clients: 12 May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:05 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 16:11:05 volumio volumio[1020]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 07 16:11:05 volumio volumio[1020]: info: Received Get System Info May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:11:05 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:05 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:05 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:05 volumio volumio[1020]: info: Listing playlists May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 16:11:05 volumio volumio[1020]: info: Executing endpoint metavolumio May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 07 16:11:05 volumio volumio[1020]: info: Executing endpoint metavolumio May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 07 16:11:05 volumio volumio[1020]: info: Executing endpoint metavolumio May 07 16:11:05 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 16:11:06 volumio volumio[1020]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 13 May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:11:06 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::volumioPlay May 07 16:11:06 volumio volumio[1020]: info: CoreStateMachine::play index undefined May 07 16:11:06 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 16:11:06 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:06 volumio volumio[1020]: info: CoreStateMachine::startPlaybackTimer May 07 16:11:06 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 16:11:06 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 07 16:11:06 volumio volumio[1020]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%227cRGjXswX_8%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22UCHE%20YARA%20-%20ZUU%20(zoo)%20%7C%20A%20COLORS%20SHOW%22%2C%22artist%22%3A%22COLORS%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F7cRGjXswX_8%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCi49iJIEf0u8TJ52gyDqIX6dNMfg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%227cRGjXswX_8%22%7D%7D%7D May 07 16:11:06 volumio volumio[1020]: info: [youtube2] InnertubeLoader: creating Innertube instance... May 07 16:11:07 volumio volumio[1020]: info: [youtube2] InnertubeLoader: creating Auth instance... May 07 16:11:07 volumio volumio[1020]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 16:11:07 volumio volumio[1020]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 16:11:07 volumio volumio[1020]: info: [youtube2] InnertubeLoader: Auth instance created (status: signed in) May 07 16:11:08 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:08 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand stop May 07 16:11:08 volumio volumio[1020]: info: CoreCommandRouter::volumioGetQueue May 07 16:11:08 volumio volumio[1020]: info: CoreStateMachine::getQueue May 07 16:11:08 volumio volumio[1020]: info: CorePlayQueue::getQueue May 07 16:11:08 volumio volumio[1020]: info: sendMpdCommand stop took 13 milliseconds May 07 16:11:08 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand clear May 07 16:11:08 volumio volumio[1020]: info: May 07 16:11:08 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:08 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:08 volumio volumio[1020]: info: sendMpdCommand clear took 2 milliseconds May 07 16:11:08 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112667&ei=ezY6ZqfLJ7W4vdIPtvSq0Ag&ip=89.156.20.63&id=o-AALFg0RfqZ7eS2chvN0AddnembeKoq7h2isRhowPEsTp&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2S02G7XsehUSwFpseITRIMz6ZaxbA6P03Ckv5ubi9A7GXU09bHbaN4tdybtxLqt1kn2WA&spc=UWF9fySjWEyEkI-2QAqBki_v6u1dRl21G15u_KhPwqG1M1c2mxx_HftK3jUk9nU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=8yiY7EG0IcId6B4xJwnk_doQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=Q78Lob3wgWtF4A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAN_ebDnypI8prCdLb_VB0jNMSzhYyKeyxnaU6jOdm9WFAiBTdAN9em5TSnNXzmsdFSyky3OrdXbnII2APLYWlbAlXw%3D%3D&sig=AJfQdSswRQIhAL_Ai0uis8bN2NWbQ8UdUAzPBfFennGY1yXx6VR_ylvNAiB0D8AtQDXoMtXKuS57-ku25AJkgO8W989Znvmf2cFpqg%3D%3D&cver=2.20230104.01.00&t.YouTube" May 07 16:11:08 volumio volumio[1020]: error: updateQueue error: null May 07 16:11:08 volumio volumio[1020]: info: May 07 16:11:08 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:08 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:08 volumio volumio[1020]: info: ------------------------------ 19ms May 07 16:11:08 volumio volumio[1020]: info: sendMpdCommand addid "https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112667&ei=ezY6ZqfLJ7W4vdIPtvSq0Ag&ip=89.156.20.63&id=o-AALFg0RfqZ7eS2chvN0AddnembeKoq7h2isRhowPEsTp&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2S02G7XsehUSwFpseITRIMz6ZaxbA6P03Ckv5ubi9A7GXU09bHbaN4tdybtxLqt1kn2WA&spc=UWF9fySjWEyEkI-2QAqBki_v6u1dRl21G15u_KhPwqG1M1c2mxx_HftK3jUk9nU&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=8yiY7EG0IcId6B4xJwnk_doQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=Q78Lob3wgWtF4A&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRQIhAN_ebDnypI8prCdLb_VB0jNMSzhYyKeyxnaU6jOdm9WFAiBTdAN9em5TSnNXzmsdFSyky3OrdXbnII2APLYWlbAlXw%3D%3D&sig=AJfQdSswRQIhAL_Ai0uis8bN2NWbQ8UdUAzPBfFennGY1yXx6VR_ylvNAiB0D8AtQDXoMtXKuS57-ku25AJkgO8W989Znvmf2cFpqg%3D%3D&cver=2.20230104.01.00&t.YouTube" took 18 milliseconds May 07 16:11:08 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:08 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:08 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:08 volumio volumio[1020]: info: May 07 16:11:08 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:08 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:08 volumio volumio[1020]: info: ------------------------------ 18ms May 07 16:11:08 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService mpd May 07 16:11:08 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand play May 07 16:11:08 volumio volumio[1020]: info: ------------------------------ 9ms May 07 16:11:08 volumio volumio[1020]: info: sendMpdCommand play took 7 milliseconds May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::volumioPlay May 07 16:11:09 volumio volumio[1020]: info: CoreStateMachine::play index undefined May 07 16:11:09 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: CoreStateMachine::startPlaybackTimer May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 07 16:11:09 volumio volumio[1020]: info: [youtube2-play] clearAddPlayTrack: youtube2/video@endpoint:o=%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%227cRGjXswX_8%22%7D%7D@explodeTrackData:o=%7B%22title%22%3A%22UCHE%20YARA%20-%20ZUU%20(zoo)%20%7C%20A%20COLORS%20SHOW%22%2C%22artist%22%3A%22COLORS%22%2C%22albumart%22%3A%22https%3A%2F%2Fi.ytimg.com%2Fvi%2F7cRGjXswX_8%2Fhqdefault.jpg%3Fsqp%3D-oaymwEcCNACELwBSFXyq4qpAw4IARUAAIhCGAFwAcABBg%3D%3D%26rs%3DAOn4CLCi49iJIEf0u8TJ52gyDqIX6dNMfg%22%2C%22endpoint%22%3A%7B%22type%22%3A%22watch%22%2C%22payload%22%3A%7B%22videoId%22%3A%227cRGjXswX_8%22%7D%7D%7D May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces state update: player May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::getState May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces state update: player May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand status took 16 milliseconds May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::getState May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::parseState May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand status took 2 milliseconds May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand playlistinfo took 2 milliseconds May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::parseState May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::parseTrackInfo May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::pushState May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 25ms May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand playlistinfo took 3 milliseconds May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::parseTrackInfo May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::pushState May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 10ms May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand stop May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand stop took 6 milliseconds May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand clear May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces state update: player May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:09 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::getState May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand clear took 2 milliseconds May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand addid "https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112669&ei=fTY6ZqKUJoKAvdIP6NG18A0&ip=89.156.20.63&id=o-APikazAtLwcgXuGuyLAvlmzNuwWJGVIA0gi6eMAepkKk&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2QU0NiNS5dckb5W8W8-0STfApzSDGZOpS8gQSCu232FANbNeG_3d4nuybjVIj5m3WswUQ&spc=UWF9f2C4jU5XGO0_8OxauW4XNaQADNJuKCS0H5scbT6txAUqG0H_qunSoKrAdLc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=p5o2kwR8e5jVRIjpiqrh0YoQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=tFAp6xLska_4xA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgcxVYInR4C3et8829Csz7MP-uxTZO-AIl_YdQhbaKRMUCIDuHSbRFg_nks0XncmVzXS02oFE9ZduJ9-BFbDp_q8kA&sig=AJfQdSswRQIgRRv4Yb5AJHcMHgQ4wrdY-wZw0Mh65fZP7Z4aODtCEPoCIQC8vd_N_SbVm-FYsNc_E66Zo9LBGKkd9dGxByfvZuRZBg%3D%3D&cver=2.20230104.01.00&t.YouTube" May 07 16:11:09 volumio volumio[1020]: error: updateQueue error: null May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:09 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand status took 3 milliseconds May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 3ms May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand addid "https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112669&ei=fTY6ZqKUJoKAvdIP6NG18A0&ip=89.156.20.63&id=o-APikazAtLwcgXuGuyLAvlmzNuwWJGVIA0gi6eMAepkKk&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2QU0NiNS5dckb5W8W8-0STfApzSDGZOpS8gQSCu232FANbNeG_3d4nuybjVIj5m3WswUQ&spc=UWF9f2C4jU5XGO0_8OxauW4XNaQADNJuKCS0H5scbT6txAUqG0H_qunSoKrAdLc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=p5o2kwR8e5jVRIjpiqrh0YoQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=tFAp6xLska_4xA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgcxVYInR4C3et8829Csz7MP-uxTZO-AIl_YdQhbaKRMUCIDuHSbRFg_nks0XncmVzXS02oFE9ZduJ9-BFbDp_q8kA&sig=AJfQdSswRQIgRRv4Yb5AJHcMHgQ4wrdY-wZw0Mh65fZP7Z4aODtCEPoCIQC8vd_N_SbVm-FYsNc_E66Zo9LBGKkd9dGxByfvZuRZBg%3D%3D&cver=2.20230104.01.00&t.YouTube" took 3 milliseconds May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::parseState May 07 16:11:09 volumio volumio[1020]: info: ControllerMpd::pushState May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:09 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 16:11:09 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:11:09 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:11:09 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:11:09 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:09 volumio volumio[1020]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current youtube2 Received mpd May 07 16:11:09 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:09 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:09 volumio volumio[1020]: verbose: MPD COMMAND [object Object] May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 30ms May 07 16:11:09 volumio volumio[1020]: info: May 07 16:11:09 volumio volumio[1020]: ---------------------------- MPD announces system playlist update May 07 16:11:09 volumio volumio[1020]: info: Ignoring MPD Status Update May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 29ms May 07 16:11:09 volumio volumio[1020]: info: CoreStateMachine::setConsumeUpdateService mpd May 07 16:11:09 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand play May 07 16:11:09 volumio volumio[1020]: info: ------------------------------ 11ms May 07 16:11:09 volumio volumio[1020]: info: sendMpdCommand play took 10 milliseconds May 07 16:11:10 volumio volumio[1020]: info: May 07 16:11:10 volumio volumio[1020]: ---------------------------- MPD announces state update: player May 07 16:11:10 volumio volumio[1020]: info: ControllerMpd::getState May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status May 07 16:11:10 volumio volumio[1020]: info: May 07 16:11:10 volumio volumio[1020]: ---------------------------- MPD announces state update: player May 07 16:11:10 volumio volumio[1020]: info: sendMpdCommand status took 2 milliseconds May 07 16:11:10 volumio volumio[1020]: info: ControllerMpd::getState May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand status May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::parseState May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 16:11:10 volumio volumio[1020]: info: sendMpdCommand status took 8 milliseconds May 07 16:11:10 volumio volumio[1020]: info: sendMpdCommand playlistinfo took 7 milliseconds May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::parseState May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::parseTrackInfo May 07 16:11:10 volumio volumio[1020]: info: ControllerMpd::pushState May 07 16:11:10 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:10 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:10 volumio volumio[1020]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"UCHE YARA - ZUU (zoo) | A COLORS SHOW","artist":"COLORS","album":"YouTube","uri":"https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112669&ei=fTY6ZqKUJoKAvdIP6NG18A0&ip=89.156.20.63&id=o-APikazAtLwcgXuGuyLAvlmzNuwWJGVIA0gi6eMAepkKk&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2QU0NiNS5dckb5W8W8-0STfApzSDGZOpS8gQSCu232FANbNeG_3d4nuybjVIj5m3WswUQ&spc=UWF9f2C4jU5XGO0_8OxauW4XNaQADNJuKCS0H5scbT6txAUqG0H_qunSoKrAdLc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=p5o2kwR8e5jVRIjpiqrh0YoQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=tFAp6xLska_4xA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgcxVYInR4C3et8829Csz7MP-uxTZO-AIl_YdQhbaKRMUCIDuHSbRFg_nks0XncmVzXS02oFE9ZduJ9-BFbDp_q8kA&sig=AJfQdSswRQIgRRv4Yb5AJHcMHgQ4wrdY-wZw0Mh65fZP7Z4aODtCEPoCIQC8vd_N_SbVm-FYsNc_E66Zo9LBGKkd9dGxByfvZuRZBg%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} May 07 16:11:10 volumio volumio[1020]: verbose: CURRENT POSITION 0 May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::syncState stateService play May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::syncState currentStatus stop May 07 16:11:10 volumio volumio[1020]: info: ------------------------------ 13ms May 07 16:11:10 volumio volumio[1020]: info: sendMpdCommand playlistinfo took 2 milliseconds May 07 16:11:10 volumio volumio[1020]: verbose: ControllerMpd::parseTrackInfo May 07 16:11:10 volumio volumio[1020]: info: ControllerMpd::pushState May 07 16:11:10 volumio volumio[1020]: info: CoreCommandRouter::servicePushState May 07 16:11:10 volumio volumio[1020]: info: CorePlayQueue::getTrack 0 May 07 16:11:10 volumio volumio[1020]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":173,"samplerate":48,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"UCHE YARA - ZUU (zoo) | A COLORS SHOW","artist":"COLORS","album":"YouTube","uri":"https://rr4---sn-n4g-jqbek.googlevideo.com/videoplayback?expire=1715112669&ei=fTY6ZqKUJoKAvdIP6NG18A0&ip=89.156.20.63&id=o-APikazAtLwcgXuGuyLAvlmzNuwWJGVIA0gi6eMAepkKk&itag=251&source=youtube&requiressl=yes&xpc=EgVo2aDSNQ%3D%3D&mh=Jw&mm=31%2C26&mn=sn-n4g-jqbek%2Csn-h5qzened&ms=au%2Conr&mv=m&mvi=4&pl=18&initcwndbps=1338750&siu=1&bui=AWRWj2QU0NiNS5dckb5W8W8-0STfApzSDGZOpS8gQSCu232FANbNeG_3d4nuybjVIj5m3WswUQ&spc=UWF9f2C4jU5XGO0_8OxauW4XNaQADNJuKCS0H5scbT6txAUqG0H_qunSoKrAdLc&vprv=1&svpuc=1&mime=audio%2Fwebm&ns=p5o2kwR8e5jVRIjpiqrh0YoQ&gir=yes&clen=3017342&dur=173.341&lmt=1714033400196795&mt=1715090692&fvip=1&keepalive=yes&c=WEB&sefc=1&txp=4432434&n=tFAp6xLska_4xA&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cxpc%2Csiu%2Cbui%2Cspc%2Cvprv%2Csvpuc%2Cmime%2Cns%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl%2Cinitcwndbps&lsig=AHWaYeowRAIgcxVYInR4C3et8829Csz7MP-uxTZO-AIl_YdQhbaKRMUCIDuHSbRFg_nks0XncmVzXS02oFE9ZduJ9-BFbDp_q8kA&sig=AJfQdSswRQIgRRv4Yb5AJHcMHgQ4wrdY-wZw0Mh65fZP7Z4aODtCEPoCIQC8vd_N_SbVm-FYsNc_E66Zo9LBGKkd9dGxByfvZuRZBg%3D%3D&cver=2.20230104.01.00&t.YouTube","trackType":"YouTube"} May 07 16:11:10 volumio volumio[1020]: verbose: CURRENT POSITION 0 May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::syncState stateService play May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::syncState currentStatus play May 07 16:11:10 volumio volumio[1020]: info: Received an update from plugin. extracting info from payload May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:11:10 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 16:11:10 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:11:10 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:11:10 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:11:10 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:11:10 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:11:10 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:11:10 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:11:10 volumio volumio[1020]: info: ------------------------------ 31ms May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::volumioGetBrowseSources May 07 16:11:11 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 16:11:12 volumio volumio[1020]: error: Failed request for metavolumio API May 07 16:11:41 volumio kernel: rc rc0: two consecutive events of type pulse May 07 16:12:14 volumio volumio[1020]: info: [IrActivityLed] ir command received: 0000000077e140c5 00 KEY_MENU iremote May 07 16:12:14 volumio volumio[1020]: info: [IrActivityLed] Starting to blink LED May 07 16:12:14 volumio volumio[1020]: info: [IrActivityLed] Error: ENOENT: no such file or directory, open '/sys/class/leds/led1/trigger' May 07 16:12:14 volumio irexec[1420]: % Total % Received % Xferd Average Speed Time Time Time Current May 07 16:12:14 volumio irexec[1420]: Dload Upload Total Spent Left Speed May 07 16:12:14 volumio volumio[1020]: info: May 07 16:12:14 volumio volumio[1020]: ---------------------------- Client requests Random undefined May 07 16:12:14 volumio volumio[1020]: info: CoreCommandRouter::writePlayerControls May 07 16:12:14 volumio volumio[1020]: info: CoreStateMachine::setRandom true May 07 16:12:14 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:12:14 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 16:12:14 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:12:14 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:12:14 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:12:14 volumio irexec[1420]: [158B blob data] May 07 16:12:14 volumio volumio[1020]: info: [IrActivityLed] ir command received: 0000000077e140c5 01 KEY_MENU iremote May 07 16:12:24 volumio volumio[1020]: info: [IrActivityLed] ir command received: 0000000077e140c5 00 KEY_MENU iremote May 07 16:12:24 volumio volumio[1020]: info: [IrActivityLed] Starting to blink LED May 07 16:12:24 volumio volumio[1020]: info: [IrActivityLed] Error: ENOENT: no such file or directory, open '/sys/class/leds/led1/trigger' May 07 16:12:24 volumio irexec[1420]: {"time":1715091134060,"response":"random Success"} % Total % Received % Xferd Average Speed Time Time Time Current May 07 16:12:24 volumio irexec[1420]: Dload Upload Total Spent Left Speed May 07 16:12:24 volumio volumio[1020]: info: May 07 16:12:24 volumio volumio[1020]: ---------------------------- Client requests Random undefined May 07 16:12:24 volumio volumio[1020]: info: CoreCommandRouter::writePlayerControls May 07 16:12:24 volumio volumio[1020]: info: CoreStateMachine::setRandom false May 07 16:12:24 volumio volumio[1020]: info: CoreStateMachine::pushState May 07 16:12:24 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 07 16:12:24 volumio volumio[1020]: info: CoreCommandRouter::volumioPushState May 07 16:12:24 volumio volumio[1020]: info: MRS: Pushing multiroomSync output update for this device May 07 16:12:24 volumio volumio[1020]: info: MRS: Pushing multiroomSync output May 07 16:12:24 volumio irexec[1420]: [158B blob data] May 07 16:12:24 volumio volumio[1020]: info: [IrActivityLed] ir command received: 0000000077e140c5 01 KEY_MENU iremote May 07 16:12:24 volumio volumio[1020]: info: [IrActivityLed] ir command received: 0000000077e140c5 02 KEY_MENU iremote May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:12:34 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:12:34 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.86.46 from 192.168.86.62 UA: unknown Total Clients: 10 May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 07 16:12:34 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 07 16:12:36 volumio sudo[1753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 16:12:36 volumio sudo[1753]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 16:12:36 volumio sudo[1753]: pam_unix(sudo:session): session closed for user root May 07 16:12:36 volumio sudo[1756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 16:12:36 volumio sudo[1756]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 16:12:36 volumio sudo[1756]: pam_unix(sudo:session): session closed for user root May 07 16:12:36 volumio volumio[1020]: verbose: New Socket.io Connection to 192.168.86.46 from 192.168.86.62 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 11 May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::volumioGetVisibleSources May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 16:12:36 volumio volumio[1020]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 07 16:12:36 volumio volumio[1020]: info: Received Get System Info May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:12:36 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:36 volumio volumio[1020]: info: Listing playlists May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 16:12:36 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 16:12:38 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 16:12:38 volumio volumio[1020]: info: Received Get System Info May 07 16:12:38 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:12:38 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:12:38 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:12:38 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:38 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:12:39 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 16:12:39 volumio volumio[1020]: info: Received Get System Info May 07 16:12:39 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 16:12:39 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 16:12:39 volumio volumio[1020]: info: Discovery: Getting this device information May 07 16:12:39 volumio volumio[1020]: info: CoreCommandRouter::volumioGetState May 07 16:12:39 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 16:12:42 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 16:12:42 volumio volumio[1020]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 07 16:12:52 volumio volumio[1020]: info: Starting Uninstall of plugin system_hardware - iractivityled May 07 16:12:52 volumio volumio[1020]: info: Uninstalling plugin iractivityled May 07 16:12:52 volumio lircd[1414]: lircd-0.10.1[1414]: Info: removed client May 07 16:12:52 volumio lircd-0.10.1[1414]: Info: removed client May 07 16:12:52 volumio volumio[1020]: info: [IrActivityLed] releasing built-in LED May 07 16:12:52 volumio volumio[1020]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 16:12:52 volumio volumio[1020]: TypeError: Cannot read property 'toString' of undefined May 07 16:12:52 volumio volumio[1020]: at IrActivityLedController.releaseLed (/data/plugins/system_hardware/iractivityled/index.js:232:61) May 07 16:12:52 volumio volumio[1020]: at IrActivityLedController.onStop (/data/plugins/system_hardware/iractivityled/index.js:68:17) May 07 16:12:52 volumio volumio[1020]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) May 07 16:12:52 volumio volumio[1020]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) May 07 16:12:52 volumio volumio[1020]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1459:22) May 07 16:12:52 volumio volumio[1020]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1218:45) May 07 16:12:52 volumio volumio[1020]: at Socket.emit (events.js:315:20) May 07 16:12:52 volumio volumio[1020]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 07 16:12:52 volumio volumio[1020]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 07 16:12:52 volumio volumio[1020]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 16:12:52 volumio sudo[1808]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 16:11 May 07 16:12:52 volumio sudo[1808]: 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="976a78467f79e70a0355fda1bdf6131ebc1cd623" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="96f96f5841fe838bca3521ebef1c7c61c5d8f8e2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 03 May 2024 11:27:23 AM CEST" VOLUMIO_VERSION="3.666" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f30b256de2b9db7d4f62150d86161761"