Command received from Alexa, playlist started, music not playing

Post Reply
bardx
Posts: 7
Joined: Mon Mar 29, 2021 9:53 am

Command received from Alexa, playlist started, music not playing

Post by bardx »

Hi, it seems that very often (90% of the times) the music playback doesn't work.
Alexa answers to my request and says it's going to play the playlist I requested. From the MyMedia dashboard, in the "Recent Alexa Play Requests" section, I see that the playlist was recognized correctly but then the playback never starts. Here's the log of a try I made. What's going on? What's not working fine?

Code: Select all

09/04/2023 19:23:52.970 23073:0 766 PushClient.cs:Ws_OnMessage:238 Received message: {"MessageType":1,"Locale":"en-US","TransactionID":"c4e740ba-c912-4f1f-9a6c-46cffad8fc43","Album":null,"AlbumEN":null,"Song":null,"SongEN":null,"Artist":null,"ArtistEN":null,"Genre":null,"GenreEN":null,"Playlist":"PLAYLIST_NAME","BookTitle":null,"BookTitleEN":null,"Shuffle":false,"Type":-1,"SourceID":null,"SourceName":null}
09/04/2023 19:23:52.971 23073:0 766 PushClient.cs:Ws_OnMessage:251 Search was for : 
09/04/2023 19:23:52.971 23073:0 766 ServiceAgent.cs:SearchPlaylists:2426 Searching for playlist of type Any and query PLAYLIST_NAME
09/04/2023 19:23:52.972 23073:0 766 ServiceAgent.cs:SearchPlaylists:2458 Exact loop mode = 0
09/04/2023 19:23:52.974 23073:0 766 ServiceAgent.cs:SearchPlaylists:2476 Fuzzy cleaned playlist query HIT 0, score 5,394449 : PlaylistName = PLAYLIST_NAME
09/04/2023 19:23:52.975 23073:0 766 ServiceAgent.cs:SearchPlaylists:2600 Found match - name PLAYLIST_NAME, playlist id /PATH_TO_PLAYLIST/PLAYLIST_NAME.m3u, file
09/04/2023 19:23:52.975 23073:0 766 ServiceAgent.cs:SearchPlaylists:2607 Playlist has 4 tracks
09/04/2023 19:23:52.976 23073:0 766 PlaylistHistoryController.cs:AddHistory:115 Added c0a496bd-073c-4f3f-bbae-d0f58841f403; MyMediaEchoWeb.Models.PlaylistHistory
09/04/2023 19:23:52.976 23073:0 766 MessageController.cs:AddMessage:114 Added 2686051f-e15a-457f-b24b-c9dd93b67e5c; Title:RESCAN_PLAYLIST_HISTORY; Description:
09/04/2023 19:23:52.977 23073:0 766 PushClient.cs:Ws_OnMessage:304 Sending response: {"ResponseCode":200,"Playlist":{"ID":"a018fa0b-f375-4823-8b51-472d3ca6d79c","MediaClientID":"71490acd-7394-4caf-b60d-0d8a86d87349","Name":"PLAYLIST_NAME","Shuffle":false,"Loop":false,"Temporary":false,"CreateDate":"2023-04-01T23:11:04.283158+02:00","Type":2,"IsAudioBook":false,"TrackCount":4,"LastUsed":"2023-04-09T19:18:49.279952+02:00","DeviceID":"","SearchHash":"","Bookmark":null,"SourceID":"/PATH_TO_PLAYLIST/PLAYLIST_NAME.m3u","SourceName":"file"},"MessageType":2,"Locale":"en-US","TransactionID":"c4e740ba-c912-4f1f-9a6c-46cffad8fc43"}
09/04/2023 19:23:52.978 23073:0 766 PushClient.cs:Ws_OnMessage:709 Done.
09/04/2023 19:23:53.476 23073:0 765 PushClient.cs:Ws_OnMessage:238 Received message: {"MessageType":3,"Locale":"en-US","TransactionID":"1cc206df-22cd-4bee-8ac5-244916ef0b02","PlaylistId":"a018fa0b-f375-4823-8b51-472d3ca6d79c","PreviousPlaylistMediaItem":null,"TrackRequest":0,"Loop":true,"Shuffle":true,"SendImages":true}
09/04/2023 19:23:53.477 23073:0 765 PushClient.cs:Ws_OnMessage:469 PlaylistItem request was for : PlaylistId:a018fa0b-f375-4823-8b51-472d3ca6d79c, PreviousMedaiItemId:, TrackRequest:FirstTrack
09/04/2023 19:23:53.477 23073:0 765 ServiceAgent.cs:GetPlaylistMediaItem:2209 IN - try 0
09/04/2023 19:23:53.477 23073:0 765 ServiceAgent.cs:GetPlaylistMediaItem:2217 Searching tracks...
09/04/2023 19:23:53.765 23073:0 765 ServiceAgent.cs:GetPlaylistMediaItem:2334 OUT
09/04/2023 19:23:53.765 23073:0 765 PushClient.cs:Ws_OnMessage:476 Got playlistmediaitem - 762e38ee-e9b3-4d2c-a0b4-3563b85bcb23
09/04/2023 19:23:53.766 23073:0 765 PushClient.cs:Ws_OnMessage:492 Searched for b485abbf-5f18-44a8-b182-c3c83b3cbb58, Got media item - b485abbf-5f18-44a8-b182-c3c83b3cbb58
09/04/2023 19:23:53.768 23073:0 765 PushClient.cs:Ws_OnMessage:529 Generating artwork as we can't find it...
09/04/2023 19:23:53.772 23073:0 766 PushClient.cs:Ws_OnMessage:508 Preloading /PATH_TO_SONG/Marek Ztracený – Originál.mp3
09/04/2023 19:23:53.773 23073:0 766 ServiceAgent.cs:PreloadFile:2342 Start Testing getting file length - /PATH_TO_SONG/Marek Ztracený – Originál.mp3
09/04/2023 19:23:53.796 23073:0 766 ServiceAgent.cs:PreloadFile:2344 Testing getting file length: 4330392
09/04/2023 19:23:53.797 23073:0 766 ServiceAgent.cs:PreloadFile:2345 Trying to open file...
09/04/2023 19:23:53.819 23073:0 765 PushClient.cs:Ws_OnMessage:540 Image generation was within timeout threshold
09/04/2023 19:23:53.820 23073:0 765 PushClient.cs:Ws_OnMessage:549 Done
09/04/2023 19:23:53.820 23073:0 765 PushClient.cs:Ws_OnMessage:569 Serializing response...
09/04/2023 19:23:53.821 23073:0 765 PushClient.cs:Ws_OnMessage:572 Sending response: {"ResponseCode":200,"PlaylistMediaItem":{"ID":"762e38ee-e9b3-4d2c-a0b4-3563b85bcb23","PlaylistID":"a018fa0b-f375-4823-8b51-472d3ca6d79c","MediaItemID":"b485abbf-5f18-44a8-b182-c3c83b3cbb58","PlayOrder":1,"PlayOrderRandom":261,"Offset":0},"MediaItem":{"ID":"b485abbf-5f18-44a8-b182-c3c83b3cbb58","MediaClientID":"71490acd-7394-4caf-b60d-0d8a86d87349","CheckSum":"-8585225315424775808:4330392","FileName":"/PATH_TO_SONG/Marek Ztracený – Originál.mp3","PlayCount":19,"Rating":0,"Title":"Originál","ContributingArtists":"Marek Ztracený","AlbumArtist":null,"Album":"Originál","Year":0,"DiscNumber":0,"TrackNumber":0,"TrackCount":0,"Genre":"","Composer":null,"Tag":null,"SourceID":null,"SourceName":null,"Indexed":"2023-03-17T20:34:18","Codec":"MPEG Version 1 Audio, Layer 3","Duration":181,"Hidden":false,"RequiredTranscoding":0,"IsAudioBook":false,"GroupID":"00000000-0000-0000-0000-000000000000"},"SmallImage":null,"LargeImage":null,"MessageType":4,"Locale":"en-US","TransactionID":"1cc206df-22cd-4bee-8ac5-244916ef0b02"}
09/04/2023 19:23:53.821 23073:0 765 PushClient.cs:Ws_OnMessage:573 Sending response (length): 1071
09/04/2023 19:23:53.846 23073:0 766 ServiceAgent.cs:PreloadFile:2351 File opened successfully.
09/04/2023 19:23:53.857 23073:0 765 PushClient.cs:Ws_OnMessage:709 Done.
09/04/2023 19:23:57.802 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://IP_ADDRESS_OF_MYMEDIA_SERVER:52050/stream?token=MgNqn7EfYiKq9nJvoBWnq3ajiMEnhi1UdARiTgO2GVtyKuXBFDyuGWLTgEiKCq7Q
09/04/2023 19:23:57.802 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1134 Anonymous
09/04/2023 19:23:57.802 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://IP_ADDRESS_OF_MYMEDIA_SERVER:52050/stream?token=MgNqn7EfYiKq9nJvoBWnq3ajiMEnhi1UdARiTgO2GVtyKuXBFDyuGWLTgEiKCq7Q
09/04/2023 19:23:57.803 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1134 Anonymous
09/04/2023 19:23:57.803 23073:0 766 WebServer.cs:DoRequest:214 CurrentRequests Count = 1
09/04/2023 19:23:57.803 23073:0 766 WebServer.cs:DoRequest:238 WebRequest:30 from SOURCE_IP_ADDRESS_OF_THE_REQUEST, START WebServer::HTTP Request - GET url=http://IP_ADDRESS_OF_MYMEDIA_SERVER:52050/stream?token=MgNqn7EfYiKq9nJvoBWnq3ajiMEnhi1UdARiTgO2GVtyKuXBFDyuGWLTgEiKCq7Q useragent=Echo/1.0(APNG) headers=Host: IP_ADDRESS_OF_MYMEDIA_SERVER:52050
User-Agent: Echo/1.0(APNG)
Accept: */*
UniqueIdentifier: 55443
Icy-MetaData: 1


09/04/2023 19:23:57.804 23073:0 766 WebServer.cs:DoRequest:348 WebServer::DoRequest - received a token - MgNqn7EfYiKq9nJvoBWnq3ajiMEnhi1UdARiTgO2GVtyKuXBFDyuGWLTgEiKCq7Q, looking it up now...
09/04/2023 19:23:58.619 23073:0 766 WebServer.cs:DoRequest:356 WebServer::DoRequest - exchanged token for media item id b485abbf-5f18-44a8-b182-c3c83b3cbb58
09/04/2023 19:23:58.619 23073:0 766 WebServer.cs:DoRequest:478 Looking up media item
09/04/2023 19:23:58.624 23073:0 766 WebServer.cs:DoRequest:495 Streaming /PATH_TO_SONG/Marek Ztracený – Originál.mp3
09/04/2023 19:23:58.625 23073:0 766 WebServer.cs:DoRequest:568 Found - /PATH_TO_SONG/Marek Ztracený – Originál.mp3
09/04/2023 19:23:58.626 23073:0 766 WebServer.cs:DoRequest:572 Getting file handle...
09/04/2023 19:23:58.628 23073:0 766 WebServer.cs:DoRequest:632 WebServer::DoRequest - file does exist - /PATH_TO_SONG/Marek Ztracený – Originál.mp3
09/04/2023 19:23:58.632 23073:0 766 FFmpegTranscoder.cs:CleanupStreams:56 Looking for expired transcode streams
09/04/2023 19:23:58.633 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:307 Cached transcode does not exist for /PATH_TO_SONG/Marek Ztracený – Originál.mp3, spawning a new one...
09/04/2023 19:23:58.634 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:357 FFMpegTranscoder::OnTranscodeStream -  FileName = /usr/bin/ffmpeg
09/04/2023 19:23:58.634 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:358 FFMpegTranscoder::OnTranscodeStream -  Commandline = -i "/PATH_TO_SONG/Marek Ztracený – Originál.mp3" -ab 160k -ac 2 -vn -f mp3 -af volume=replaygain=track "/home/pi/.MyMediaForAlexa/TranscodeCache/1s480zml.rzg.mp3"
09/04/2023 19:23:58.635 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:376 Waiting on process to start...
09/04/2023 19:23:58.654 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:378 Process has started.
09/04/2023 19:23:58.655 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:383 FFMpegTranscoder::OnTranscodeStream - transcoding process started PID = 1148, file will be /home/pi/.MyMediaForAlexa/TranscodeCache/1s480zml.rzg.mp3...
09/04/2023 19:23:58.656 23073:0 766 FFmpegTranscoder.cs:WaitForFile:124 Waiting on file to be created...
09/04/2023 19:23:59.447 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: ffmpeg version 4.3.5-0+deb11u1+rpt3 Copyright (c) 2000-2022 the FFmpeg developers
09/04/2023 19:23:59.447 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   built with gcc 10 (Raspbian 10.2.1-6+rpi1)
09/04/2023 19:23:59.448 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --enable-shared --libdir=/usr/lib/arm-linux-gnueabihf --cpu=arm1176jzf-s --arch=arm
09/04/2023 19:23:59.448 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   WARNING: library configuration mismatch
09/04/2023 19:23:59.449 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avutil      configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.450 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avcodec     configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.450 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avformat    configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.451 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avdevice    configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.452 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avfilter    configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.452 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   avresample  configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.453 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   swscale     configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.453 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   swresample  configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.454 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   postproc    configuration: --prefix=/usr --extra-version=0+deb11u1+rpt3 --toolchain=hardened --incdir=/usr/include/arm-linux-gnueabihf --enable-gpl --disable-stripping --enable-avresample --disable-filter=resample --enable-gnutls --enable-ladspa --enable-libaom --enable-libass --enable-libbluray --enable-libbs2b --enable-libcaca --enable-libcdio --enable-libcodec2 --enable-libdav1d --enable-libflite --enable-libfontconfig --enable-libfreetype --enable-libfribidi --enable-libgme --enable-libgsm --enable-libjack --enable-libmp3lame --enable-libmysofa --enable-libopenjpeg --enable-libopenmpt --enable-libopus --enable-libpulse --enable-librabbitmq --enable-librsvg --enable-librubberband --enable-libshine --enable-libsnappy --enable-libsoxr --enable-libspeex --enable-libsrt --enable-libssh --enable-libtheora --enable-libtwolame --enable-libvidstab --enable-libvorbis --enable-libvpx --enable-libwavpack --enable-libwebp --enable-libx265 --enable-libxml2 --enable-libxvid --enable-libzmq --enable-libzvbi --enable-lv2 --enable-omx --enable-openal --enable-opencl --enable-opengl --enable-sdl2 --enable-mmal --enable-neon --enable-rpi --enable-v4l2-request --enable-libudev --enable-epoxy --enable-pocketsphinx --enable-libdc1394 --enable-libdrm --enable-vout-drm --enable-libiec61883 --enable-chromaprint --enable-frei0r --enable-libx264 --libdir=/usr/lib/arm-linux-gnueabihf/neon/vfp --cpu=cortex-a7 --arch=armv6t2 --disable-thumb --enable-shared --disable-doc --disable-programs
09/04/2023 19:23:59.455 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavutil      56. 51.100 / 56. 51.100
09/04/2023 19:23:59.456 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavcodec     58. 91.100 / 58. 91.100
09/04/2023 19:23:59.456 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavformat    58. 45.100 / 58. 45.100
09/04/2023 19:23:59.456 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavdevice    58. 10.100 / 58. 10.100
09/04/2023 19:23:59.457 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavfilter     7. 85.100 /  7. 85.100
09/04/2023 19:23:59.457 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libavresample   4.  0.  0 /  4.  0.  0
09/04/2023 19:23:59.457 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libswscale      5.  7.100 /  5.  7.100
09/04/2023 19:23:59.458 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libswresample   3.  7.100 /  3.  7.100
09/04/2023 19:23:59.458 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   libpostproc    55.  7.100 / 55.  7.100
09/04/2023 19:23:59.472 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: [mp3 @ 0x73cd10] Estimating duration from bitrate, this may be inaccurate
09/04/2023 19:23:59.472 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: Input #0, mp3, from '/PATH_TO_SONG/Marek Ztracený – Originál.mp3':
09/04/2023 19:23:59.473 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   Metadata:
09/04/2023 19:23:59.473 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:                     : major_brand
09/04/2023 19:23:59.473 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     encoder         : Lavf60.4.100
09/04/2023 19:23:59.474 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     album           : Originál
09/04/2023 19:23:59.474 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     title           : Originál
09/04/2023 19:23:59.474 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     album_artist    : Marek Ztracený
09/04/2023 19:23:59.475 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     artist          : Marek Ztracený
09/04/2023 19:23:59.475 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     date            : 2022
09/04/2023 19:23:59.475 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   Duration: 00:03:00.25, start: 0.000000, bitrate: 192 kb/s
09/04/2023 19:23:59.476 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     Stream #0:0: Audio: mp3, 44100 Hz, stereo, fltp, 192 kb/s
09/04/2023 19:23:59.476 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: Stream mapping:
09/04/2023 19:23:59.477 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   Stream #0:0 -> #0:0 (mp3 (mp3float) -> mp3 (libmp3lame))
09/04/2023 19:23:59.477 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: Press [q] to stop, [?] for help
09/04/2023 19:23:59.483 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: Output #0, mp3, to '/home/pi/.MyMediaForAlexa/TranscodeCache/1s480zml.rzg.mp3':
09/04/2023 19:23:59.484 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:   Metadata:
09/04/2023 19:23:59.484 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:                     : major_brand
09/04/2023 19:23:59.484 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TDRC            : 2022
09/04/2023 19:23:59.485 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TALB            : Originál
09/04/2023 19:23:59.485 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TIT2            : Originál
09/04/2023 19:23:59.485 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TPE2            : Marek Ztracený
09/04/2023 19:23:59.486 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TPE1            : Marek Ztracený
09/04/2023 19:23:59.486 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     TSSE            : Lavf58.45.100
09/04/2023 19:23:59.486 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     Stream #0:0: Audio: mp3 (libmp3lame), 44100 Hz, stereo, fltp, 160 kb/s
09/04/2023 19:23:59.486 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:     Metadata:
09/04/2023 19:23:59.487 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug:       encoder         : Lavc58.91.100 libmp3lame
09/04/2023 19:23:59.981 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=      72kB time=00:00:03.63 bitrate= 162.7kbits/s speed=7.21x    
09/04/2023 19:24:00.482 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     143kB time=00:00:07.23 bitrate= 161.3kbits/s speed=7.21x    
09/04/2023 19:24:00.984 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     206kB time=00:00:10.47 bitrate= 160.9kbits/s speed=6.96x    
09/04/2023 19:24:01.485 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     256kB time=00:00:13.71 bitrate= 152.9kbits/s speed=6.83x    
09/04/2023 19:24:01.987 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     256kB time=00:00:17.29 bitrate= 121.3kbits/s speed=6.89x    
09/04/2023 19:24:02.489 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     256kB time=00:00:20.76 bitrate= 101.0kbits/s speed=6.89x    
09/04/2023 19:24:02.989 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     256kB time=00:00:24.32 bitrate=  86.2kbits/s speed=6.92x    
09/04/2023 19:24:03.493 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     512kB time=00:00:27.95 bitrate= 150.1kbits/s speed=6.96x    
09/04/2023 19:24:03.994 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     512kB time=00:00:31.29 bitrate= 134.0kbits/s speed=6.93x    
09/04/2023 19:24:04.495 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     512kB time=00:00:34.58 bitrate= 121.3kbits/s speed=6.89x    
09/04/2023 19:24:04.995 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     512kB time=00:00:38.19 bitrate= 109.8kbits/s speed=6.92x    
09/04/2023 19:24:05.498 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     768kB time=00:00:41.66 bitrate= 151.0kbits/s speed=6.92x    
09/04/2023 19:24:05.998 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     768kB time=00:00:45.08 bitrate= 139.5kbits/s speed=6.91x    
09/04/2023 19:24:06.516 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     768kB time=00:00:48.45 bitrate= 129.8kbits/s speed= 6.9x    
09/04/2023 19:24:07.003 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=     768kB time=00:00:51.88 bitrate= 121.3kbits/s speed=6.89x    
09/04/2023 19:24:07.504 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1024kB time=00:00:55.11 bitrate= 152.2kbits/s speed=6.87x    
09/04/2023 19:24:08.004 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1024kB time=00:00:58.75 bitrate= 142.8kbits/s speed=6.89x    
09/04/2023 19:24:08.505 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1024kB time=00:01:02.01 bitrate= 135.3kbits/s speed=6.87x    
09/04/2023 19:24:09.008 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1024kB time=00:01:05.35 bitrate= 128.3kbits/s speed=6.86x    
09/04/2023 19:24:09.510 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1280kB time=00:01:08.46 bitrate= 153.1kbits/s speed=6.83x    
09/04/2023 19:24:10.013 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1280kB time=00:01:11.86 bitrate= 145.9kbits/s speed=6.82x    
09/04/2023 19:24:10.517 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1280kB time=00:01:14.78 bitrate= 140.2kbits/s speed=6.78x    
09/04/2023 19:24:11.020 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1280kB time=00:01:17.87 bitrate= 134.7kbits/s speed=6.75x    
09/04/2023 19:24:11.521 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1536kB time=00:01:20.79 bitrate= 155.7kbits/s speed=6.71x    
09/04/2023 19:24:12.026 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1536kB time=00:01:23.95 bitrate= 149.9kbits/s speed=6.69x    
09/04/2023 19:24:12.527 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1536kB time=00:01:27.09 bitrate= 144.5kbits/s speed=6.67x    
09/04/2023 19:24:13.030 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1536kB time=00:01:30.09 bitrate= 139.7kbits/s speed=6.65x    
09/04/2023 19:24:13.531 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1792kB time=00:01:33.12 bitrate= 157.6kbits/s speed=6.63x    
09/04/2023 19:24:14.034 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1792kB time=00:01:36.23 bitrate= 152.5kbits/s speed=6.61x    
09/04/2023 19:24:14.537 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1792kB time=00:01:39.50 bitrate= 147.5kbits/s speed=6.61x    
09/04/2023 19:24:15.040 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    1792kB time=00:01:42.55 bitrate= 143.1kbits/s speed=6.59x    
09/04/2023 19:24:15.541 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2048kB time=00:01:45.84 bitrate= 158.5kbits/s speed=6.59x    
09/04/2023 19:24:16.043 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2048kB time=00:01:49.06 bitrate= 153.8kbits/s speed=6.58x    
09/04/2023 19:24:16.545 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2048kB time=00:01:52.11 bitrate= 149.6kbits/s speed=6.57x    
09/04/2023 19:24:17.045 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2048kB time=00:01:55.30 bitrate= 145.5kbits/s speed=6.56x    
09/04/2023 19:24:17.546 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2304kB time=00:01:58.70 bitrate= 159.0kbits/s speed=6.57x    
09/04/2023 19:24:18.048 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2304kB time=00:02:02.04 bitrate= 154.7kbits/s speed=6.57x    
09/04/2023 19:24:18.549 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2304kB time=00:02:05.51 bitrate= 150.4kbits/s speed=6.58x    
09/04/2023 19:24:19.049 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2304kB time=00:02:09.01 bitrate= 146.3kbits/s speed=6.59x    
09/04/2023 19:24:19.552 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2560kB time=00:02:12.46 bitrate= 158.3kbits/s speed= 6.6x    
09/04/2023 19:24:20.055 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2560kB time=00:02:15.94 bitrate= 154.3kbits/s speed=6.61x    
09/04/2023 19:24:20.555 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2560kB time=00:02:19.28 bitrate= 150.6kbits/s speed=6.61x    
09/04/2023 19:24:21.058 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2560kB time=00:02:22.39 bitrate= 147.3kbits/s speed= 6.6x    
09/04/2023 19:24:21.561 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2816kB time=00:02:25.68 bitrate= 158.3kbits/s speed= 6.6x    
09/04/2023 19:24:22.062 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2816kB time=00:02:28.82 bitrate= 155.0kbits/s speed=6.59x    
09/04/2023 19:24:22.565 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2816kB time=00:02:31.95 bitrate= 151.8kbits/s speed=6.58x    
09/04/2023 19:24:23.066 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    2816kB time=00:02:35.09 bitrate= 148.7kbits/s speed=6.57x    
09/04/2023 19:24:23.568 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3072kB time=00:02:38.35 bitrate= 158.9kbits/s speed=6.57x    
09/04/2023 19:24:24.069 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3072kB time=00:02:41.49 bitrate= 155.8kbits/s speed=6.57x    
09/04/2023 19:24:24.572 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3072kB time=00:02:44.65 bitrate= 152.8kbits/s speed=6.56x    
09/04/2023 19:24:25.074 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3072kB time=00:02:48.30 bitrate= 149.5kbits/s speed=6.58x    
09/04/2023 19:24:25.573 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3328kB time=00:02:55.57 bitrate= 155.3kbits/s speed=6.73x    
09/04/2023 19:24:25.858 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: size=    3522kB time=00:03:00.24 bitrate= 160.1kbits/s speed=6.83x    
09/04/2023 19:24:25.859 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: video:0kB audio:3521kB subtitle:0kB other streams:0kB global headers:0kB muxing overhead: 0.019498%
09/04/2023 19:24:25.879 23073:0 766 FFmpegTranscoder.cs:process_ErrorDataReceived:454 FFMpegTranscoder::OnTranscodeStream - 1148 Debug: 
09/04/2023 19:24:25.879 23073:0 766 FFmpegTranscoder.cs:WaitForFile:128 File exists
09/04/2023 19:24:25.880 23073:0 766 FFmpegTranscoder.cs:CreateTranscodeStream:391 File created - /home/pi/.MyMediaForAlexa/TranscodeCache/1s480zml.rzg.mp3
09/04/2023 19:24:25.881 23073:0 766 WebServer.cs:DoRequest:859 WebRequest:30 Serving /PATH_TO_SONG/Marek Ztracený – Originál.mp3bytes 0-2684354558/2684354559 MimeType:audio/mp3
09/04/2023 19:24:25.882 23073:0 766 WebServer.cs:DoRequest:860 WebRequest:30 Response Code: 200, headers: Server: Windows NT (unknown), UPnP/1.0 DLNADOC/1.50, MyMediaEcho/1.0
ETag: "Marek+Ztracen%c3%bd+%e2%80%93+Origin%c3%a1l+(ofici%c3%a1ln%c3%ad+videoklip).mp3Fri, 17 Mar 2023 17:49:03 GMT"
Last-Modified: Fri, 17 Mar 2023 17:49:03 GMT
transferMode.dlna.org: Streaming
realTimeInfo.dlna.org: DLNA.ORG_TLAG=*
X-UA-Compatible: IE=edge
Content-Type: audio/mp3


09/04/2023 19:24:25.951 23073:0 766 WebServer.cs:DoRequest:983 WebRequest:30 - Error - System.IO.IOException: Unable to write data to the transport connection: The socket has been shut down. ---> System.Net.Sockets.SocketException: The socket has been shut down
  at System.Net.Sockets.Socket.EndSend (System.IAsyncResult asyncResult) [0x00012] in <a63b52a3a7644f60a95b388cb72441c2>:0 
  at System.Net.Sockets.NetworkStream.EndWrite (System.IAsyncResult asyncResult) [0x00057] in <a63b52a3a7644f60a95b388cb72441c2>:0 
   --- End of inner exception stack trace ---
  at System.Net.Sockets.NetworkStream.EndWrite (System.IAsyncResult asyncResult) [0x0009b] in <a63b52a3a7644f60a95b388cb72441c2>:0 
  at System.Net.ResponseStream.EndWrite (System.IAsyncResult ares) [0x00051] in <a63b52a3a7644f60a95b388cb72441c2>:0 
  at System.IO.Stream+<>c.<BeginEndWriteAsync>b__53_1 (System.IO.Stream stream, System.IAsyncResult asyncResult) [0x00000] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at (wrapper delegate-invoke) System.Func`3[System.IO.Stream,System.IAsyncResult,System.Threading.Tasks.VoidTaskResult].invoke_TResult_T1_T2(System.IO.Stream,System.IAsyncResult)
  at System.Threading.Tasks.TaskFactory`1+FromAsyncTrimPromise`1[TResult,TInstance].Complete (TInstance thisRef, System.Func`3[T1,T2,TResult] endMethod, System.IAsyncResult asyncResult, System.Boolean requiresSynchronization) [0x00000] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
--- End of stack trace from previous location where exception was thrown ---
  at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw () [0x0000c] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at System.Runtime.CompilerServices.TaskAwaiter.ThrowForNonSuccess (System.Threading.Tasks.Task task) [0x0003e] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at System.Runtime.CompilerServices.TaskAwaiter.HandleNonSuccessAndDebuggerNotification (System.Threading.Tasks.Task task) [0x00028] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at System.Runtime.CompilerServices.TaskAwaiter.ValidateEnd (System.Threading.Tasks.Task task) [0x00008] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at System.Runtime.CompilerServices.TaskAwaiter.GetResult () [0x00000] in <b0e32063e1e04cbf802ab56dcffac4b0>:0 
  at MyMediaEchoService.Web.WebServer+<DoRequest>d__14.MoveNext () [0x02d3e] in <bc37082d672a41398f69948d31f49e8e>:0 
09/04/2023 19:24:25.952 23073:0 766 WebServer.cs:DoRequest:1020 WebRequest:30 Closing stream.
09/04/2023 19:24:25.953 23073:0 766 WebServer.cs:DoRequest:1040 WebRequest:30 Closed.
09/04/2023 19:24:25.962 23073:0 766 FFmpegTranscoder.cs:process_Exited:421 FFMpegTranscoder::OnTranscodeStream - process 1148 has finished with exit code 0
09/04/2023 19:24:25.964 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://URL_OF_MYMEDIA_SERVER:52051/index.html
09/04/2023 19:24:25.965 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1139 Basic
09/04/2023 19:24:25.965 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://URL_OF_MYMEDIA_SERVER:52051/index.html
09/04/2023 19:24:25.966 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1139 Basic
09/04/2023 19:24:25.966 23073:0 766 WebServer.cs:DoRequest:214 CurrentRequests Count = 1
09/04/2023 19:24:25.967 23073:0 766 WebServer.cs:DoRequest:238 WebRequest:31 from SOURCE_IP_ADDRESS_OF_THE_REQUEST, START WebServer::HTTP Request - GET url=http://URL_OF_MYMEDIA_SERVER:52051/index.html useragent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 headers=Host: URL_OF_MYMEDIA_SERVER:52051
Connection: keep-alive
Cache-Control: max-age=0
Authorization: Basic YWRtaW46Q2FzYU15TWVkaWE0JA==
Upgrade-Insecure-Requests: 1
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36
Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/avif,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.7
Accept-Encoding: gzip, deflate
Accept-Language: it-IT,it;q=0.9,en-US;q=0.8,en;q=0.7
Cookie: csm-hit=tb:ABR1A44NFMP2FSB5B9WA+s-WKR8NGN625C4BXDQTJX7|1662317551205&t:1662317551205&adb:adblk_yes
If-None-Match: "index.htmlSun, 09 Apr 2023 15:47:42 GMT"
If-Modified-Since: Sun, 09 Apr 2023 15:47:42 GMT


09/04/2023 19:24:25.967 23073:0 766 WebServer.cs:DoRequest:285 User: admin
09/04/2023 19:24:25.968 23073:0 766 WebServer.cs:DoRequest:365 Hostname = URL_OF_MYMEDIA_SERVER:52051
09/04/2023 19:24:25.968 23073:0 766 WebServer.cs:DoRequest:366 Path = /index.html
09/04/2023 19:24:25.969 23073:0 766 WebServer.cs:DoRequest:572 Getting file handle...
09/04/2023 19:24:25.969 23073:0 766 WebServer.cs:DoRequest:859 WebRequest:31 Serving index.htmlbytes 0-11518/11519 MimeType:text/html
09/04/2023 19:24:25.970 23073:0 766 WebServer.cs:DoRequest:860 WebRequest:31 Response Code: 200, headers: Server: Windows NT (unknown), UPnP/1.0 DLNADOC/1.50, MyMediaEcho/1.0
ETag: "index.htmlSun, 09 Apr 2023 15:47:42 GMT"
Last-Modified: Sun, 09 Apr 2023 15:47:42 GMT
transferMode.dlna.org: Streaming
realTimeInfo.dlna.org: DLNA.ORG_TLAG=*
X-UA-Compatible: IE=edge
Accept-Range: bytes
Content-Type: text/html
Content-Length: 11519


09/04/2023 19:24:25.972 23073:0 766 WebServer.cs:DoRequest:938 WebRequest:31 Flushing 11519 bytes out of 11519 in 1 read(s) (11519 bytes read per read)...
09/04/2023 19:24:25.972 23073:0 766 WebServer.cs:DoRequest:941 WebRequest:31 Flushed
09/04/2023 19:24:25.973 23073:0 766 WebServer.cs:DoRequest:950 WebRequest:31 sent what we agreed to send
09/04/2023 19:24:25.973 23073:0 766 WebServer.cs:DoRequest:965 WebRequest:31 END
09/04/2023 19:24:25.973 23073:0 766 WebServer.cs:DoRequest:1020 WebRequest:31 Closing stream.
09/04/2023 19:24:25.974 23073:0 766 WebServer.cs:DoRequest:1040 WebRequest:31 Closed.
09/04/2023 19:24:26.331 23073:0 615 ServiceAgent.cs:CheckSubscription:410 Checking with My Media server for a subscription...
09/04/2023 19:24:26.407 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://URL_OF_MYMEDIA_SERVER:52051/lib/fonts/fontawesome-webfont.woff2?v=4.5.0
09/04/2023 19:24:26.407 23073:0 765 WebServer.cs:AuthenticationSchemeForClient:1139 Basic
09/04/2023 19:24:26.408 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1124 Client authentication protocol selection in progress...http://URL_OF_MYMEDIA_SERVER:52051/lib/fonts/fontawesome-webfont.woff2?v=4.5.0
09/04/2023 19:24:26.408 23073:0 05 WebServer.cs:AuthenticationSchemeForClient:1139 Basic
09/04/2023 19:24:26.409 23073:0 766 WebServer.cs:DoRequest:214 CurrentRequests Count = 1
09/04/2023 19:24:26.409 23073:0 766 WebServer.cs:DoRequest:238 WebRequest:32 from SOURCE_IP_ADDRESS_OF_THE_REQUEST, START WebServer::HTTP Request - GET url=http://URL_OF_MYMEDIA_SERVER:52051/lib/fonts/fontawesome-webfont.woff2?v=4.5.0 useragent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36 headers=Host: URL_OF_MYMEDIA_SERVER:52051
Connection: keep-alive
Authorization: Basic YWRtaW46Q2FzYU15TWVkaWE0JA==
Origin: http://URL_OF_MYMEDIA_SERVER:52051
User-Agent: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/111.0.0.0 Safari/537.36
Accept: */*
Referer: http://URL_OF_MYMEDIA_SERVER:52051/lib/css/main.min.css?v=1642946195107
Accept-Encoding: gzip, deflate
Accept-Language: it-IT,it;q=0.9,en-US;q=0.8,en;q=0.7
Cookie: csm-hit=tb:ABR1A44NFMP2FSB5B9WA+s-WKR8NGN625C4BXDQTJX7|1662317551205&t:1662317551205&adb:adblk_yes
...
negev
Posts: 2
Joined: Sat May 06, 2023 2:41 am

Re: Command received from Alexa, playlist started, music not playing

Post by negev »

Just curious did you ever receive a response?
bardx
Posts: 7
Joined: Mon Mar 29, 2021 9:53 am

Re: Command received from Alexa, playlist started, music not playing

Post by bardx »

Never received a response.
Post Reply