-- Logs begin at Sun 2024-07-14 13:47:52 UTC, end at Sun 2024-07-14 14:39:41 UTC. -- Jul 14 14:38:11 opera volumio[1344]: info: CorePlayQueue::getTrack 3 Jul 14 14:38:11 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:11 opera volumio[1344]: info: Prefetching next song Jul 14 14:38:11 opera volumio[1344]: info: Doing Prefetch in UPNP Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/213842.aif" Jul 14 14:38:11 opera volumio[1344]: info: Jul 14 14:38:11 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:11 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:11 opera volumio[1344]: info: sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/213842.aif" took 1 milliseconds Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 14 14:38:11 opera volumio[1344]: info: Jul 14 14:38:11 opera volumio[1344]: ---------------------------- MPD announces state update: options Jul 14 14:38:11 opera volumio[1344]: info: ------------------------------ 2ms Jul 14 14:38:11 opera volumio[1344]: info: sendMpdCommand consume 1 took 1 milliseconds Jul 14 14:38:11 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:11 opera volumio[1344]: info: sendMpdCommand status took 0 milliseconds Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:11 opera volumio[1344]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 14 14:38:11 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:11 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:11 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:11 opera volumio[1344]: info: CoreStateMachine::startPlaybackTimer Jul 14 14:38:11 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:11 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:11 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":189482,"duration":194,"samplerate":"96 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"213841.aif","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/213841.aif","trackType":"aif"} Jul 14 14:38:11 opera volumio[1344]: verbose: CURRENT POSITION 4 Jul 14 14:38:11 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:11 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus play Jul 14 14:38:11 opera volumio[1344]: info: Received an update from plugin. extracting info from payload Jul 14 14:38:11 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:11 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:11 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:11 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:11 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:11 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:11 opera volumio[1344]: info: ------------------------------ 12ms Jul 14 14:38:11 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:11 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:16 opera volumio[1344]: info: Jul 14 14:38:16 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:16 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:16 opera volumio[1344]: info: Jul 14 14:38:16 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:16 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:16 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:16 opera volumio[1344]: info: ------------------------------ 1ms Jul 14 14:38:16 opera volumio[1344]: info: sendMpdCommand status took 0 milliseconds Jul 14 14:38:16 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:16 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:16 opera volumio[1344]: info: sendMpdCommand playlistinfo took 0 milliseconds Jul 14 14:38:16 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:16 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:16 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:16 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:16 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":"96 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"213842.aif","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/213842.aif","trackType":"aif"} Jul 14 14:38:16 opera volumio[1344]: verbose: CURRENT POSITION 4 Jul 14 14:38:16 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:16 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus play Jul 14 14:38:16 opera volumio[1344]: info: Received an update from plugin. extracting info from payload Jul 14 14:38:16 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:16 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:16 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:16 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:16 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:16 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:16 opera volumio[1344]: info: ------------------------------ 9ms Jul 14 14:38:16 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:16 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:19 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:20 opera dhcpd[1383]: DHCPDISCOVER from 70:66:55:e6:c1:31 (opera) via wlan0 Jul 14 14:38:21 opera dhcpd[1383]: DHCPOFFER on 192.168.211.17 to 70:66:55:e6:c1:31 (opera) via wlan0 Jul 14 14:38:21 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:22 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:38:23 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Susan%20Wong/511/8044a924-1311-41c5-b876-b9718e835fd3.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Billy%20Joel/52nd%20Street/7d8ffcd8-e342-46ac-b737-ad9c717e26b6.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/George%20Lam/60Min.28Sec.%20George%20Gallery/f601dccf-d627-4fcb-894f-8bd33bfb198d.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Piano%20Guys/A%20Family%20Christmas/00e5b480-0e63-41cd-869d-0bbc6d284cea.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Faye%20Wong/A%20Fei%20Zheng%20Chuan/2243e96e-c8d5-480a-b27d-b46a2760c590.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Cass%20Phang/A%20Flower/111ecdc7-8b78-4477-8777-c0a75675a35e.jpg' Jul 14 14:38:31 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Tracy%20Huang/A%20Gambler/74691c5f-0753-4296-bb32-3077e88537a6.jpg' Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/John%20Coltrane/A%20Love%20Supreme%3A%20Live%20In%20Seattle/9d0df207-eb92-4e50-bfcd-52535941fd43.jpg' Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Celtic%20Woman/A%20New%20Journey/7eecc05a-2d86-49cd-b295-b8daea106e0d.jpg' Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lady%20Gaga%20%26%20Bradley%20Cooper/A%20Star%20Is%20Born/51aa9ca0-7654-4285-8aab-35c6f659c7f4.jpg' Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joe%20Hisaishi/A%20Symphonic%20Celebration%20-%20Music%20from%20the%20Studio%20Ghibli%20Films%20of%20Hayao%20Miyazaki/0a865019-08db-4d50-b37f-8666e6724d2f.jpg' Jul 14 14:38:32 opera volumio[1344]: info: CoreCommandRouter::volumioGetState Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Kaleo/A%2FB/4de10b23-1092-45f5-bf9b-b927b077f2c6.jpg' Jul 14 14:38:32 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 14 14:38:32 opera volumio[1344]: error: Could not retrieve plugin audio_interface multiroom Jul 14 14:38:32 opera volumio[1344]: info: Listing playlists Jul 14 14:38:32 opera volumio[1344]: info: CoreCommandRouter::volumioGetVisibleSources Jul 14 14:38:32 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 14 14:38:32 opera volumio[1344]: info: CoreCommandRouter::volumioGetQueue Jul 14 14:38:32 opera volumio[1344]: info: CoreStateMachine::getQueue Jul 14 14:38:32 opera volumio[1344]: info: CorePlayQueue::getQueue Jul 14 14:38:32 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Marian%20Hill/ACT%20ONE/b7940fbb-dc5e-4d41-8855-b74b5956b17f.jpg' Jul 14 14:38:33 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:33 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Beatles/Abbey%20Road/34b628f4-bb9d-4eac-9602-cd5d7d5ab28b.jpg' Jul 14 14:38:33 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/The%20Beatles/Abbey%20Road%20(24%20BIT%20Remastered)/7cdc0847-3031-422d-b525-4a66c1e96f1c.jpg' Jul 14 14:38:34 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anne-Sophie%20Mutter/Across%20The%20Stars%20(Deluxe%20Edition)/5f9770d7-7acb-4c6b-9931-8bd0d1f1425f.jpg' Jul 14 14:38:34 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Douglas%20Dare/Aforger/205359e6-7316-4110-a406-62a2fe0fd8b3.jpg' Jul 14 14:38:34 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Leslie%20Cheung/Ai%20Mu/945c094e-f0ac-46dd-90d7-7f063d87f772.png' Jul 14 14:38:34 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Teresa%20Teng/Ai%20Zhi%20Shi%20Jie/2040e924-bfda-4be1-a7cc-39902fea99a6.jpg' Jul 14 14:38:35 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anne%20Akiko%20Meyers/Air%3A%20The%20Bach%20Album/ce4a8e53-ca14-41cb-a029-31859d4f22ef.jpg' Jul 14 14:38:35 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lawson%20Rollins/Airwaves%3A%20The%20Greatest%20Hits/243af11b-01ed-49bc-8dec-c6ce0900101a.jpg' Jul 14 14:38:36 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Armik/Alchemy/cf44fca9-1b54-493a-8f58-66478fc3898e.jpg' Jul 14 14:38:36 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Armik/Alegra/f238a1a8-1120-4439-ac4e-8a51164daaf5.jpg' Jul 14 14:38:36 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hiromi/Alive/1d244b8f-1977-4752-abe1-80d7179536f1.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Carol%20Kidd/All%20My%20Tomorrows/bdefa744-ea20-4dcd-9303-a5728752e5b7.png' Jul 14 14:38:37 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/George%20Lam/All%20The%20Best/cf17ac42-6db3-47ed-b972-a36ae3422401.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jai-Jagdeesh/All%20is%20Now%20Light/d034c5aa-095b-4ab6-a555-a5e4e08bcbbf.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Celine%20Dion/All%20the%20Way...A%20Decade%20of%20Song/f7a5696f-263a-4177-9dae-a7efa633ff43.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Christina%20Pluhar/Alla%20Napoletana/15f4ac48-3c48-49e7-aa17-5a441729ff34.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yes/Almost%20Famous/2945dcb1-947b-4178-9d76-c8fb3a99f56e.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Eleanor%20McEvoy/Alone/417cc6fb-85de-473e-b67a-39646f5b72b0.jpg' Jul 14 14:38:37 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Gianmaria%20Testa/Altre%20latitudini/14da2660-0a0f-4561-b5e6-ea8dff889bc4.jpg' Jul 14 14:38:38 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lea%20Desandre/Amazone/c8e1f952-8233-4c24-9cc5-ba715be82a2e.jpg' Jul 14 14:38:38 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Don%20McLean/American%20Pie%20%5BWorld%20Plus%20Bonus%20Tracks%5D%20SACD/eefe28cb-e9e4-4239-82fd-1c987aa31e73.jpg' Jul 14 14:38:38 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Radiohead/Amnesiac/dd556106-9af9-4e5d-b21a-a9b2ecaea7c0.jpg' Jul 14 14:38:38 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrea%20Bocelli/Amore/9cfb40ac-0e45-4ce5-807c-4f93203afad9.jpg' Jul 14 14:38:38 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%B5%E5%AD%B8%E5%8F%8B/Amour/163a48eb-eaa9-4a2a-a4cc-84f82678ed3e.png' Jul 14 14:38:38 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:38 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:38:39 opera volumio[1344]: info: CoreCommandRouter::volumioGetState Jul 14 14:38:39 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:38:39 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:38:40 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Cassandra%20Wilson/Another%20Country/133209ef-ad2a-4ab5-8a21-97ab5b4ccea7.jpg' Jul 14 14:38:40 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hiromi%20Uehara/Another%20Mind/1b86d89a-5e2f-4b73-b599-ad05e700fb2f.jpg' Jul 14 14:38:41 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ray%20Conniff/April%20In%20Paris/64a73990-3e67-419d-8327-0e4b3ef8b5c2.jpg' Jul 14 14:38:42 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Art%20Pepper/Art%20Pepper%20%26%20Eleven%20Modern%20Jazz%20Classics/831cbb80-2405-4846-a5c4-6d7ff75cef71.jpg' Jul 14 14:38:43 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Avi%20Avital/Art%20of%20the%20Mandolin/59eb173d-9713-4028-a151-d0996666698b.jpg' Jul 14 14:38:43 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Asia/Asia/43c7051c-1d7c-46f9-9cd5-9f4ace05430c.png' Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::ClearQueue Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::stop Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:44 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::stPlaybackTimer Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::updateTrackBlock Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrackBlock Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::serviceStop Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 4 Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::serviceStop Jul 14 14:38:44 opera volumio[1344]: info: [1720967924156] ControllerUPNPBrowser::stop Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::clearPlayQueue Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::saveQueue Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushQueue Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::addQueueItems Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::addQueueItems Jul 14 14:38:44 opera volumio[1344]: info: Adding Item to queue: upnp/folder/http://192.168.3.38:50001/ContentDirectory/control@22$25708 Jul 14 14:38:44 opera volumio[1344]: info: Exploding uri upnp/folder/http://192.168.3.38:50001/ContentDirectory/control@22$25708 in service upnp_browser Jul 14 14:38:44 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:44 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::saveQueue Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushQueue Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::updateTrackBlock Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrackBlock Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPlay Jul 14 14:38:44 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::play index 0 Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::stop Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:44 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::play index undefined Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::startPlaybackTimer Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:44 opera volumio[1344]: info: [1720967924213] ControllerUPNPBrowser::clearAddPlayTrack Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand stop took 95 milliseconds Jul 14 14:38:44 opera volumio[1344]: info: Jul 14 14:38:44 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:44 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand stop took 40 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand clear Jul 14 14:38:44 opera volumio[1344]: info: Jul 14 14:38:44 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:44 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand status took 3 milliseconds Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand clear took 2 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.38:50002/m/NDLNA/221577.wav" Jul 14 14:38:44 opera volumio[1344]: error: updateQueue error: null Jul 14 14:38:44 opera volumio[1344]: info: ------------------------------ 4ms Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:44 opera volumio[1344]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 14 14:38:44 opera volumio[1344]: info: ------------------------------ 9ms Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221577.wav" Jul 14 14:38:44 opera volumio[1344]: info: Jul 14 14:38:44 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:44 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221577.wav" took 1 milliseconds Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand play Jul 14 14:38:44 opera volumio[1344]: info: ------------------------------ 4ms Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand play took 1 milliseconds Jul 14 14:38:44 opera volumio[1344]: info: Jul 14 14:38:44 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:44 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:44 opera volumio[1344]: info: Jul 14 14:38:44 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:44 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand status took 2 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand status took 3 milliseconds Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:44 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:44 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221577.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221577.wav","trackType":"wav"} Jul 14 14:38:44 opera volumio[1344]: verbose: CURRENT POSITION 0 Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus stop Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:44 opera volumio[1344]: info: ------------------------------ 12ms Jul 14 14:38:44 opera volumio[1344]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 14 14:38:44 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:44 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:44 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:44 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":266,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221577.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221577.wav","trackType":"wav"} Jul 14 14:38:44 opera volumio[1344]: verbose: CURRENT POSITION 0 Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus play Jul 14 14:38:44 opera volumio[1344]: info: Received an update from plugin. extracting info from payload Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:44 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:44 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:44 opera volumio[1344]: info: ------------------------------ 27ms Jul 14 14:38:44 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:44 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:44 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:44 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Various%20Artists/Audiogon%20Presents%20The%20Wake%20Up%20Your%20Ears%20Sampler/8c30cb82-5f91-4a62-bf27-1f853441b13e.jpg' Jul 14 14:38:46 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Chantal%20Chamberland/Autobiography/d6a3e601-f276-448b-aba3-7339ffd4e51c.jpg' Jul 14 14:38:47 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Agnes%20Obel/Aventine/664fff06-f7e8-4f00-8b24-587f8549eb24.jpg' Jul 14 14:38:47 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alt-J/Awesome%20Wave/9afc5f47-4721-4f18-854b-fe57dbdfdfb9.jpg' Jul 14 14:38:47 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Gary%20Peacock/Azure/81d03795-fbe9-4f94-bdf9-98adec9bf9b1.jpg' Jul 14 14:38:48 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Daniil%20Trifonov/BACH%3A%20The%20Art%20of%20Life/5df82ef6-86f3-4612-970f-40d9b6bb6b08.jpg' Jul 14 14:38:49 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Miles%20Davis/BIG%20FUN/1445984f-c4f1-47c7-bbdb-87ecbf68ac48.jpg' Jul 14 14:38:52 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joachim%20Eijlander/Bach%20Cello%20Suites%20Vol.1/bb2b6c34-22bb-4641-91e2-9bc297229b3a.jpg' Jul 14 14:38:54 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vladimir%20Ashkenazy/Bach%3A%20English%20Suites%201-3/5041e812-6394-4de2-b117-1323be3df3e1.jpg' Jul 14 14:38:54 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Glenn%20Gould/Bach%3A%20Goldberg%20Variations/11c09ef7-3deb-4c4b-a654-e9f45c1ae3bc.jpg' Jul 14 14:38:54 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Gary%20Moore/Bad%20for%20You%20Baby/c74033c3-2abe-40be-a2fb-eaa3cb88373e.jpg' Jul 14 14:38:55 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Armik/Barcelona/9fd9e355-1b40-43df-a527-620b32558a73.jpg' Jul 14 14:38:55 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Barney%20Kessel/Barney%20Kessel/aa691bc0-e868-4878-906b-479c5a4c2353.jpg' Jul 14 14:38:56 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Vilde%20Frang/Bart%C3%B3k%3A%20Violin%20Concerto%20No.%201%20-%20Enescu%3A%20Octet/d9250ab7-1a6c-47ae-8bd8-5ef8ff6345c9.jpg' Jul 14 14:38:56 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Gregory%20Porter/Be%20Good/8f10b99f-ce8a-4b39-8f7c-fd6a0df9e972.jpg' Jul 14 14:38:56 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dave%20Douglas/Be%20Still/f22bd330-04dd-404b-85df-3c3f2ca6da39.jpg' Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPlay Jul 14 14:38:56 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::play index 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::stop Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:56 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::stPlaybackTimer Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::updateTrackBlock Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrackBlock Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::serviceStop Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::serviceStop Jul 14 14:38:56 opera volumio[1344]: info: [1720967936532] ControllerUPNPBrowser::stop Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: info: Jul 14 14:38:56 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand stop took 98 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::play index undefined Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::startPlaybackTimer Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: info: [1720967936632] ControllerUPNPBrowser::clearAddPlayTrack Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand status took 3 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand stop took 3 milliseconds Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand clear Jul 14 14:38:56 opera volumio[1344]: info: Jul 14 14:38:56 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:56 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand clear took 4 milliseconds Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.38:50002/m/NDLNA/221574.wav" Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221577.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221577.wav","trackType":"wav"} Jul 14 14:38:56 opera volumio[1344]: verbose: CURRENT POSITION 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState stateService stop Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus stop Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: No code Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: ------------------------------ 25ms Jul 14 14:38:56 opera volumio[1344]: error: updateQueue error: null Jul 14 14:38:56 opera volumio[1344]: info: ------------------------------ 18ms Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221574.wav" Jul 14 14:38:56 opera volumio[1344]: info: Jul 14 14:38:56 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:38:56 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221574.wav" took 7 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand play Jul 14 14:38:56 opera volumio[1344]: info: ------------------------------ 3ms Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand play took 2 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: Jul 14 14:38:56 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:56 opera volumio[1344]: info: Jul 14 14:38:56 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand status took 5 milliseconds Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand status took 6 milliseconds Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221574.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221574.wav","trackType":"wav"} Jul 14 14:38:56 opera volumio[1344]: verbose: CURRENT POSITION 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus stop Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: ------------------------------ 37ms Jul 14 14:38:56 opera volumio[1344]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 14 14:38:56 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:38:56 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:38:56 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:38:56 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221574.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221574.wav","trackType":"wav"} Jul 14 14:38:56 opera volumio[1344]: verbose: CURRENT POSITION 9 Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus play Jul 14 14:38:56 opera volumio[1344]: info: Received an update from plugin. extracting info from payload Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:38:56 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:38:56 opera volumio[1344]: info: ------------------------------ 87ms Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:38:56 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:06 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yo-Yo%20Ma/Beethoven%20for%20Three%3A%20Symphonies%20Nos.%202%20and%205/75db56cc-72d4-4007-95a6-962cb78b2b13.jpg' Jul 14 14:39:07 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Arthur%20Rubinstein/Beethoven%3A%20Sonatas%20(Moonlight%3B%20Les%20Adieux%3B%20Pathetique%3B%20Appassionata)/4a66ac42-1c1d-4ec9-9709-5a4a6e98d125.jpg' Jul 14 14:39:10 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Norah%20Jones/Begin%20Again/d220b056-1ee0-49d2-94a8-6be76238d695.jpg' Jul 14 14:39:10 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andreas%20Vollenweider/Behind%20the%20Gardens%2C%20Behind%20the%20Wall%2C%20Under%20the%20Tree.../bfe5bd03-f92c-40e4-921b-9071f2e263dc.jpg' Jul 14 14:39:10 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Harry%20Belafonte/Belafonte%20At%20Carnegie%20Hall/1335259c-96bd-4a0a-accb-165866e960fe.jpg' Jul 14 14:39:10 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ben%20Webster/Ben%20Webster%20Meets%20Oscar%20Peterson/8a25e421-64d3-4365-b816-e126e0a973c6.jpg' Jul 14 14:39:11 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Jul 14 14:39:11 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:39:12 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Krystian%20Zimerman/Bernstein%3A%20Symphony%20No.%202%20%22The%20Age%20of%20Anxiety%22/b3e11e03-9b57-4b0b-9724-b760e87d624a.png' Jul 14 14:39:12 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Armik/Besos/db9cdea2-bfef-42a9-8c8c-42cddb61c991.png' Jul 14 14:39:12 opera volumio[1868]: [Vollibrespot] : couldn't parse packet from V4(192.168.3.113:5353): query type 65 is invalid Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::ClearQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::stop Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:39:13 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::stPlaybackTimer Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::updateTrackBlock Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrackBlock Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::serviceStop Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::serviceStop Jul 14 14:39:13 opera volumio[1344]: info: [1720967953020] ControllerUPNPBrowser::stop Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::clearPlayQueue Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::saveQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::addQueueItems Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::addQueueItems Jul 14 14:39:13 opera volumio[1344]: info: Adding Item to queue: upnp/folder/http://192.168.3.38:50001/ContentDirectory/control@22$25716 Jul 14 14:39:13 opera volumio[1344]: info: Exploding uri upnp/folder/http://192.168.3.38:50001/ContentDirectory/control@22$25716 in service upnp_browser Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand stop took 15 milliseconds Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand status took 1 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"221574.wav","artist":null,"album":null,"uri":"http://192.168.3.38:50002/m/NDLNA/221574.wav","trackType":"wav"} Jul 14 14:39:13 opera volumio[1344]: verbose: CURRENT POSITION 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState stateService stop Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus stop Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: No code Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 9 Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 17ms Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::saveQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::updateTrackBlock Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrackBlock Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPlay Jul 14 14:39:13 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::play index 0 Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::stop Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:39:13 opera volumio[1344]: verbose: UNSET VOLATILE Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::play index undefined Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::startPlaybackTimer Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:13 opera volumio[1344]: info: [1720967953100] ControllerUPNPBrowser::clearAddPlayTrack Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand stop Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand stop took 2 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand clear Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:39:13 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand clear took 2 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.3.38:50002/m/NDLNA/221650.flac" Jul 14 14:39:13 opera volumio[1344]: error: updateQueue error: null Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 8ms Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221650.flac" Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:39:13 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand add "http://192.168.3.38:50002/m/NDLNA/221650.flac" took 2 milliseconds Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand play Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 4ms Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand play took 3 milliseconds Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces system playlist update Jul 14 14:39:13 opera volumio[1344]: info: Ignoring MPD Status Update Jul 14 14:39:13 opera volumio[1344]: info: Jul 14 14:39:13 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand status took 1 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 4ms Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand status took 3 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand playlistinfo took 3 milliseconds Jul 14 14:39:13 opera volumio[1344]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:39:13 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:13 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"一生有意义","artist":"徐小明&吴非凡","album":"撼江湖 限量签名版","uri":"http://192.168.3.38:50002/m/NDLNA/221650.flac","trackType":"flac"} Jul 14 14:39:13 opera volumio[1344]: verbose: CURRENT POSITION 0 Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus stop Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:13 opera volumio[1344]: verbose: STATE SERVICE {"status":"play","position":0,"seek":46,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"一生有意义","artist":"徐小明&吴非凡","album":"撼江湖 限量签名版","uri":"http://192.168.3.38:50002/m/NDLNA/221650.flac","trackType":"flac"} Jul 14 14:39:13 opera volumio[1344]: verbose: CURRENT POSITION 0 Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState stateService play Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus play Jul 14 14:39:13 opera volumio[1344]: info: Received an update from plugin. extracting info from payload Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 26ms Jul 14 14:39:13 opera volumio[1344]: info: ------------------------------ 25ms Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioGetQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::getQueue Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreCommandRouter::volumioGetQueue Jul 14 14:39:13 opera volumio[1344]: info: CoreStateMachine::getQueue Jul 14 14:39:13 opera volumio[1344]: info: CorePlayQueue::getQueue Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:13 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:14 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/Beyond%2024K%20Mastersonic%20Compilation/4bc359b0-beaa-4892-bbc4-a6366ce93b54.png' Jul 14 14:39:14 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%8D%A2%E5%86%A0%E5%BB%B7/Beyond%20Imagination/ac7ae88b-e8e8-45a7-853c-6bf2edfb995f.jpg' Jul 14 14:39:14 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Daniela%20Andrade/Billie%20Jean%20-%20Single/f6f4822c-20cb-494d-81bc-51e94df559f7.png' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Isao%20Szuki%20Trio/Black%20Orpheus/4ad74237-c1c0-4084-9d72-ac2035ecde25.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Peter%20Gregson/Blackbird%20(Original%20Motion%20Picture%20Soundtrack)/2155e9ea-eaac-45b0-a5ac-821c6f1fd001.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sally%20Yeh/Blessing%20You/3de5c33e-e0ee-4e1a-88d3-a4a35d795e3b.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shoji%20Yokouchi/Blonde%20On%20The%20Rocks/a7f8b955-b530-49fe-8cf7-5887a09d80ed.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Areni%20Agbabian/Bloom/8c874b40-bb50-4319-89d2-6b688390b42d.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Isao%20Suzuki%20Trio%2FQuartet/Blow%20Up/dfac6333-f3fb-453d-9ad8-23ebabcbf324.jpg' Jul 14 14:39:15 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Diana%20Panton/Blue/1eb1d03f-3f59-4b69-b9ad-92fcdb050cd5.jpg' Jul 14 14:39:18 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Peter%20Finger/Blue%20Moon/0d8ca726-728c-4e89-b345-dc1d14d1da38.jpg' Jul 14 14:39:18 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/John%20Coltrane/Blue%20Train/f43556c5-9e67-4915-9167-ef7c4c3f68c6.png' Jul 14 14:39:18 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Anna%20Tivel/Blue%20World/d63b42c3-a815-41c6-8069-52c1161acfe5.jpg' Jul 14 14:39:19 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Joni%20Mitchell/Both%20Sides%20Now/2ea0132e-c153-4956-87e1-7132472af80c.jpg' Jul 14 14:39:19 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Bryan%20Ferry/Boys%20And%20Girls/093ada6a-456f-4238-b56d-b625a3318008.jpg' Jul 14 14:39:23 opera dhcpd[1383]: DHCPDISCOVER from 70:66:55:e6:c1:31 (opera) via wlan0 Jul 14 14:39:24 opera dhcpd[1383]: DHCPOFFER on 192.168.211.17 to 70:66:55:e6:c1:31 (opera) via wlan0 Jul 14 14:39:27 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jascha%20Heifetz%2C%20violin%3B%20Fritz%20Reiner%2C%20conductor%3B%20Chicago%20Symphony%20Orchestra/Brahms%3A%20Violin%20Concerto%3B%20Tchaikovsky%3A%20Violin%20Concerto/a8a426af-e51d-4321-a39f-b3777193b208.jpg' Jul 14 14:39:27 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hiromi%20Uehara/Brain/c0c64a8b-aa73-431d-9b2f-f2d7fd32e512.jpg' Jul 14 14:39:27 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dr.%20Lonnie%20Smith/Breathe/d35456ae-762e-4a53-b70b-dce658d2be22.jpg' Jul 14 14:39:27 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sandy%20Lam/Breathe%20Me/a7a4ebe3-94e8-4c60-8626-c994b7eeffeb.jpg' Jul 14 14:39:27 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Kenny%20G/Breathless/c158f328-853d-4211-9b30-7729a28b45f0.jpg' Jul 14 14:39:28 opera volumio[1344]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dire%20Straits/Brothers%20In%20Arms%20-%2020th%20Anniversary%20Edition/3e75ed09-cc60-48f0-91a6-06b00bf839bc.jpg' Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::volumioPause Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::pause Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::stPlaybackTimer Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::servicePause Jul 14 14:39:37 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::servicePause Jul 14 14:39:37 opera volumio[1344]: info: [1720967977657] ControllerUPNPBrowser::pause Jul 14 14:39:37 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand pause Jul 14 14:39:37 opera volumio[1344]: info: Jul 14 14:39:37 opera volumio[1344]: ---------------------------- MPD announces state update: player Jul 14 14:39:37 opera volumio[1344]: info: sendMpdCommand pause took 58 milliseconds Jul 14 14:39:37 opera volumio[1344]: info: ControllerMpd::getState Jul 14 14:39:37 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand status Jul 14 14:39:37 opera volumio[1344]: info: sendMpdCommand status took 1 milliseconds Jul 14 14:39:37 opera volumio[1344]: verbose: ControllerMpd::parseState Jul 14 14:39:37 opera volumio[1344]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 14 14:39:37 opera volumio[1344]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 14 14:39:37 opera volumio[1344]: verbose: ControllerMpd::parseTrackInfo Jul 14 14:39:37 opera volumio[1344]: info: ControllerMpd::pushState Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::servicePushState Jul 14 14:39:37 opera volumio[1344]: info: CorePlayQueue::getTrack 0 Jul 14 14:39:37 opera volumio[1344]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":24775,"duration":170,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1414 Kbps","isStreaming":false,"title":"一生有意义","artist":"徐小明&吴非凡","album":"撼江湖 限量签名版","uri":"http://192.168.3.38:50002/m/NDLNA/221650.flac","trackType":"flac"} Jul 14 14:39:37 opera volumio[1344]: verbose: CURRENT POSITION 0 Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::syncState stateService pause Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::syncState currentStatus pause Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::pushState Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::volumioPushState Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::stPlaybackTimer Jul 14 14:39:37 opera volumio[1344]: info: ------------------------------ 13ms Jul 14 14:39:37 opera volumio[1344]: info: CoreCommandRouter::volumioGetQueue Jul 14 14:39:37 opera volumio[1344]: info: CoreStateMachine::getQueue Jul 14 14:39:37 opera volumio[1344]: info: CorePlayQueue::getQueue Jul 14 14:39:37 opera volumio[1344]: info: Updating RAAT Signal Path Jul 14 14:39:40 opera volumio[1344]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 14:39:40 opera volumio[1344]: { Error: connect ETIMEDOUT 199.16.156.38:443 Jul 14 14:39:40 opera volumio[1344]: at Object._errnoException (util.js:1022:11) Jul 14 14:39:40 opera volumio[1344]: at _exceptionWithHostPort (util.js:1044:20) Jul 14 14:39:40 opera volumio[1344]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Jul 14 14:39:40 opera volumio[1344]: code: 'ETIMEDOUT', Jul 14 14:39:40 opera volumio[1344]: errno: 'ETIMEDOUT', Jul 14 14:39:40 opera volumio[1344]: syscall: 'connect', Jul 14 14:39:40 opera volumio[1344]: address: '199.16.156.38', Jul 14 14:39:40 opera volumio[1344]: port: 443 } Jul 14 14:39:40 opera volumio[1344]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 14 14:39:41 opera sudo[4923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-14 14:38 Jul 14 14:39:41 opera sudo[4923]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="047a38c6e11e7058b10d3038ac9dcbff94f92828" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="opera" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Apr 8 17:29:57 CEST 2022" VOLUMIO_VERSION="1.033" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_VENDOR="Opera Consonance" VOLUMIO_MODEL="X5" VOLUMIO_VENDOR_MODEL="Opera X5" VOLUMIO_HASH="77fa3b0bf86939c934741dd9bb62adcc"