Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

No sound #222

Closed
notian85 opened this issue Dec 15, 2019 · 6 comments
Closed

No sound #222

notian85 opened this issue Dec 15, 2019 · 6 comments

Comments

@notian85
Copy link

Hi Phillipe,

Thanks for your hard work and am looking forward to get it to work to get my sonos speakers to work better for me :)

For some reason AirConnect seems to connect to my speakers but not make any sound. I am using a Raspbarry Pi Model B as a platform. Please see below log:

pi@raspberrypi:~/Desktop/AirConnect $ ./airupnp-arm -I
[20:44:36.555820] main:1363 Starting airupnp version: v0.2.22.1 (Nov 9 2019 @ 12:15:33)
[20:44:36.632180] Start:1089 Binding to 192.168.1.85:49152
[20:44:36.771544] AddMRDevice:979 [0x96f48] skipping Sonos slave Family Room
[20:44:36.781057] MasterHandler:649 [0x96f48]: subscribe success
[20:44:36.822272] AddMRDevice:981 [0x99388]: adding renderer (Family Room)
[20:44:36.829804] MasterHandler:649 [0x99388]: subscribe success
[20:44:37.192799] UpdateThread:786 [0x96f48]: Sonos Family Room+ is now slave
[20:44:46.604981] rtsp_thread:351 got RTSP connection 12
[20:44:46.747287] handle_rtsp:399 [0x70e03718]: challenge Ij07zJuFaHtix7eGbWuo6Q==
[20:44:46.825179] handle_rtsp:392 [0x70e03718]: received ANNOUNCE
[20:44:46.858998] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 3

[20:44:46.866825] handle_rtsp:392 [0x70e03718]: received SETUP
[20:44:46.870181] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Transport: RTP/AVP/UDP;unicast;mode=record;control_port=60010;timing_port=58947;server_port=47145
Session: DEADBEEF
Audio-Jack-Status: connected; type=analog
CSeq: 4

[20:44:46.874612] handle_rtsp:392 [0x70e03718]: received RECORD
[20:44:46.874681] hairtunes_record:498 [0x70401530]: record 0 0
[20:44:46.874730] callback:289 [0x99388]: Stream
[20:44:46.874837] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 5

[20:44:46.878509] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:46.878613] handle_rtsp:557 [0x70e03718]: SET PARAMETER volume -24.375000
[20:44:46.878680] CtrlSetVolume:245 [0x96f48]: uPNP volume 19 (cookie (nil))
[20:44:46.878977] callback:378 [0x96f48]: Volume[0..100] 18:20
[20:44:46.879027] CtrlSetVolume:245 [0x99388]: uPNP volume 19 (cookie (nil))
[20:44:46.879442] callback:378 [0x99388]: Volume[0..100] 18:20
[20:44:46.879596] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 6

[20:44:46.892406] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:46.892776] handle_rtsp:557 [0x70e03718]: SET PARAMETER volume -24.375000
[20:44:46.893000] CtrlSetVolume:245 [0x96f48]: uPNP volume 20 (cookie 0x1)
[20:44:46.894903] callback:378 [0x96f48]: Volume[0..100] 19:18
[20:44:46.895525] CtrlSetVolume:245 [0x99388]: uPNP volume 20 (cookie 0x1)
[20:44:46.896112] callback:378 [0x99388]: Volume[0..100] 19:18
[20:44:46.896555] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 7

[20:44:46.903333] rtp_thread_func:730 [0x70401530]: 1st sync packet received
[20:44:46.950495] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:46.950686] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 8

[20:44:46.954838] rtp_thread_func:730 [0x70401530]: 1st sync packet received
[20:44:46.955437] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:46.955508] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 9

[20:44:46.958857] handle_rtsp:392 [0x70e03718]: received FLUSH
[20:44:46.958909] hairtunes_flush:474 [0x70401530]: FLUSH ignored as same as RECORD (1962 - 1899118336)
[20:44:46.958939] hairtunes_flush:486 [0x70401530]: flush 1962 1899118336
[20:44:46.958998] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 10

[20:44:46.962765] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:46.962897] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:44:46.963007] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 11

[20:44:47.003655] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.003825] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 12

[20:44:47.016902] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.017051] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 13

[20:44:47.020558] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.020665] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:44:47.020768] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 14

[20:44:47.271302] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.271457] handle_rtsp:574 [0x70e03718]: received metadata
artist:
album: Loading...
title: I Don't Care
[20:44:47.271724] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 15

[20:44:47.562396] search_remote_cb:627 [0x70e03718]: found ActiveRemote for 43708076F63A478A at 192.168.1.83:54924
[20:44:47.804725] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.804964] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:44:47.805403] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 16

[20:44:47.811538] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:47.811758] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 17

[20:44:57.294141] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:57.294362] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:44:57.294516] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 23

[20:44:59.433702] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:59.433888] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:44:59.434060] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 25

[20:44:59.439250] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:44:59.439380] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 26

^[[A^[[A^[[A^[[A^[[A^[[A^[[A^[[A^[[A[20:46:06.290630] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.290909] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:46:06.291379] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 60

[20:46:06.295866] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.296071] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 61

[20:46:06.300402] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.300608] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 62

[20:46:06.888887] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.889130] handle_rtsp:574 [0x70e03718]: received metadata
artist: Ed Sheeran & Justin Bieber
album: I Don't Care
title: I Don't Care
[20:46:06.889592] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 63

[20:46:06.894047] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.894173] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 64

[20:46:06.922550] handle_rtsp:392 [0x70e03718]: received SET_PARAMETER
[20:46:06.922918] handle_rtsp:589 [0x70e03718]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 65

THanks for you help!!!!

Ian

@philippe44
Copy link
Owner

Likely a firewall issue

@Fredje65
Copy link

Fredje65 commented Jan 1, 2020

Hi @philippe44 ,

Thanks for putting your time and expertise in something a lot of people benefit from!

Can you please help me a bit in my try to get your AirUPnP working with my Philips AW2000 internet receivers?
I am a simple user, educated long time ago as electronics engineer with some SW programming experiences. After having been desperate for some time about not being able to use my Philips AW2000 receivers anymore with my Apple devices to stream anything on e.g. my iPhone, I bumped into your AirUPnP utility – GREAT! I reconned this can be the bridge I need, ref page 4 of the AW2000 manual: "With this wireless Hi-Fi receiver connected to an existing speaker system, you can listen to music sent from a DLNA / UPnP compatible APP. "
So I installed AirUPnP on my Windows PC first to try it out. If I could get that to working, then I would try to install it on my Synology NAS (DS213+), following THIS explanation I found. But first test on PC.
Initially it looked promising: without Config.xml it already recognized my AW2000’s (‘Garage’ and ‘Terras’): Schermfoto 2020-01-01 om 19 40 51

And when switching to ‘Terras’ it seemed to switch, I saw several promising messages in the AirUPnP window (I think...), however no sound from my AW2000.
Then I thought: let’s try to play with the config.xml. So I exported the reference file with –i (very helpful!) and tried some settings. Below log is from a session with attached config.xml.
Again, all looked fine on screen, but no sound from the speakers still and soon I saw a ‘received TEARDOWN’ and log stopped, see below. This looked wrong to me... (btw: is 'DEADBEEF' a bad sign too? :-)). What is going wrong?

My challenge is that I cannot interpret the messages at all, so I’d like to ask your help. Can you hint me in a right direction please?
I searched for more info on (command line) parameters, nothing found other than in your post. And unfortunately when using -h the screen only blinked and nothing appeared that could give me more info either.

Very much appreciate your analysis and suggestions how to further analyze or debug my situation!! Thanks in advance!!

---------log-------------
used config.xml:
config.zip

[19:50:01.640] main:1363 Starting airupnp version: v0.2.23.0 (Dec 19 2019 @ 23:00:52)
[19:50:01.733] Start:1089 Binding to 192.168.1.24:49153
[19:50:05.247] AddMRDevice:981 [004ABB98]: adding renderer (Terras)
[19:50:05.278] MasterHandler:649 [004ABB98]: subscribe success
[19:50:06.484] AddMRDevice:981 [004ADFC8]: adding renderer (Garage)
[19:50:06.500] MasterHandler:649 [004ADFC8]: subscribe success
[19:50:06.626] AddMRDevice:981 [004B03F8]: adding renderer (40" Philips 8008)
[19:50:06.673] MasterHandler:649 [004B03F8]: subscribe success
[19:50:09.785] rtsp_thread:334 got RTSP connection 1172
[19:50:09.791] rtsp_thread:349 RTSP close 1172
[19:50:09.795] rtsp_thread:334 got RTSP connection 1168
[19:50:09.797] rtsp_thread:349 RTSP close 1168
[19:50:09.803] rtsp_thread:334 got RTSP connection 1168
[19:50:09.809] rtsp_thread:349 RTSP close 1168
[19:50:10.874] AddMRDevice:981 [004B2828]: adding renderer (Woonkamer)
[19:50:10.891] MasterHandler:649 [004B2828]: subscribe success
[19:50:14.732] rtsp_thread:334 got RTSP connection 1228
[19:50:14.732] rtsp_thread:349 RTSP close 1228
[19:50:14.732] rtsp_thread:334 got RTSP connection 1228
[19:50:14.732] rtsp_thread:349 RTSP close 1228
[19:50:14.748] rtsp_thread:334 got RTSP connection 1228
[19:50:14.748] rtsp_thread:349 RTSP close 1228
[19:50:14.748] rtsp_thread:334 got RTSP connection 1228
[19:50:14.763] rtsp_thread:349 RTSP close 1228
[19:50:22.979] rtsp_thread:334 got RTSP connection 716
[19:50:23.201] handle_rtsp:382 [0199C1B0]: challenge lVDAqdkeao7NAChYiRv8pQ==
[19:50:23.732] handle_rtsp:375 [0199C1B0]: received ANNOUNCE
[19:50:23.748] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 3

[19:50:23.795] handle_rtsp:375 [0199C1B0]: received SETUP
[19:50:23.795] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Transport: RTP/AVP/UDP;unicast;mode=record;control_port=59403;timing_port=59404;server_port=59402
Session: DEADBEEF
Audio-Jack-Status: connected; type=analog
CSeq: 4

[19:50:23.857] handle_rtsp:375 [0199C1B0]: received RECORD
[19:50:23.857] hairtunes_record:496 [0190F0D0]: record 0 0
[19:50:23.857] callback:289 [004ABB98]: Stream
[19:50:23.857] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 5

[19:50:23.857] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:23.857] handle_rtsp:540 [0199C1B0]: SET PARAMETER volume -16.370560
[19:50:23.857] CtrlSetVolume:244 [004ABB98]: uPNP volume 45 (cookie 00000000)
[19:50:23.857] callback:364 [004ABB98]: Volume[0..100] 45
[19:50:23.857] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 6

[19:50:23.889] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:23.889] handle_rtsp:540 [0199C1B0]: SET PARAMETER volume -16.370560
rtp_thread_func:728 [0190F0D0]: 1st sync packet received
[19:50:23.889] CtrlSetVolume:244 [004ABB98]: uPNP volume 45 (cookie 00000001)
[19:50:23.889] callback:364 [004ABB98]: Volume[0..100] 45
[19:50:23.889] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 7

[19:50:23.935] rtp_thread_func:728 [0190F0D0]: 1st sync packet received
[19:50:23.935] handle_rtsp:375 [0199C1B0]: received FLUSH
[19:50:23.935] hairtunes_flush:472 [0190F0D0]: FLUSH ignored as same as RECORD (17086 - 4068521084)
[19:50:23.935] hairtunes_flush:484 [0190F0D0]: flush 17086 4068521084
[19:50:23.935] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 8

[19:50:23.935] flac_init:216 [0190F0D0]: Using FLAC-0 (019B48C0)
[19:50:23.935] buffer_put_packet:612 [0190F0D0]: fill [level:1] [W:17086 R:17086]
[19:50:24.265] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.265] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 9

[19:50:24.468] search_remote_cb:610 [0199C1B0]: found ActiveRemote for 2B0912E9AF6B151B at 192.168.1.19:51706
[19:50:24.515] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.515] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 10

[19:50:24.531] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.531] handle_rtsp:557 [0199C1B0]: received metadata
artist: Supertramp
album: Even In The Quietest Moments
title: Fool's Overture
[19:50:24.531] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 11

[19:50:24.706] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.706] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 12

[19:50:24.721] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.721] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 13

[19:50:24.768] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:24.768] handle_rtsp:557 [0199C1B0]: received metadata
artist: Supertramp
album: Even In The Quietest Moments
title: Fool's Overture
[19:50:24.768] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 14

[19:50:25.161] AVTSetURI:90 [004ABB98]: uPNP setURI http://192.168.1.24:58539/stream.flc (cookie 00000002)
[19:50:25.162] AVTPlay:150 [004ABB98]: uPNP play (cookie 00000003)
[19:50:25.628] http_thread_func:1051 [0190F0D0]: got HTTP connection 1056 (silent frames 0)
[19:50:25.628] handle_http:1234 [0190F0D0]: received HEAD
[19:50:25.628] handle_http:1279 [0190F0D0]: responding:
HTTP/1.0 200 OK
Server: HairTunes
Content-Type: audio/flac
Connection: close

[19:50:25.628] _buffer_get_frame:952 [0190F0D0]: drain [level:208 gap:21] [W:17294 R:17086] [R:0 S:0 F:0]
[19:50:25.628] http_thread_func:1070 HTTP close 1056
[19:50:25.725] http_thread_func:1051 [0190F0D0]: got HTTP connection 1056 (silent frames 0)
[19:50:25.741] handle_http:1234 [0190F0D0]: received GET
[19:50:25.741] handle_http:1279 [0190F0D0]: responding:
HTTP/1.0 200 OK
Server: HairTunes
Content-Type: audio/flac
Connection: close

[19:50:28.062] buffer_put_packet:612 [0190F0D0]: fill [level:32] [W:17598 R:17567]
[19:50:30.429] raop_notify:303 [0199C1B0]: sending airplay remote
GET /ctrl-int/1/stop HTTP/1.0
Active-Remote: 4235350726
Connection: close

<== received ==>
HTTP/1.1 200 OK
Date: Wed, 01 Jan 2020 18:50:32 GMT
Content-Length: 0

[19:50:30.431] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:30.436] ActionHandler:520 [004ABB98]: uPNP stopped
[19:50:30.439] handle_rtsp:557 [0199C1B0]: received metadata
artist: Supertramp
album: Even In The Quietest Moments
title: Fool's Overture
[19:50:30.442] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 18

[19:50:30.946] handle_rtsp:375 [0199C1B0]: received SET_PARAMETER
[19:50:30.946] handle_rtsp:557 [0199C1B0]: received metadata
artist: Supertramp
album: Even In The Quietest Moments
title: Fool's Overture
[19:50:30.962] handle_rtsp:572 [0199C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 19

[19:50:32.138] buffer_put_packet:612 [0190F0D0]: fill [level:544] [W:18110 R:17567]
[19:50:32.625] handle_rtsp:375 [0199C1B0]: received TEARDOWN
[19:50:32.688] rtp_thread_func:817 [0190F0D0]: terminating


@philippe44
Copy link
Owner

It seems that your player is requesting a HTTP "HEAD" before the "GET" which is legit. I don't understand why I've not had the issue before. Please try 0.2.24.0, it might solve the issue

@Fredje65
Copy link

Fredje65 commented Jan 5, 2020

Thanks @philippe44 for you rapid reply! Tried 0.2.24.0 but not yet successful. AW2000 switched on, but no sound still. Any more hints?

Config.zip attached. config.zip

Log:

HTTP/1.0 200 OK
Server: HairTunes
Content-Type: audio/flac
Connection: close

[14:53:51.603] http_thread_func:1070 HTTP close 1300
[14:53:51.869] http_thread_func:1051 [019B9810]: got HTTP connection 1304 (silent frames 0)
[14:53:51.869] handle_http:1234 [019B9810]: received GET
[14:53:51.869] handle_http:1279 [019B9810]: responding:
HTTP/1.0 200 OK
Server: HairTunes
Content-Type: audio/flac
Connection: close

[14:53:51.869] _buffer_get_frame:952 [019B9810]: drain [level:151 gap:230] [W:4649 R:4498] [R:0 S:0 F:0]
[14:53:52.229] http_thread_func:1186 [019B9810]: spent 219 ms in send for 1853 bytes (sent 1853)!
[14:53:52.489] ActionHandler:520 [004ABB9C]: uPNP stopped
[14:53:54.754] buffer_put_packet:612 [019B9810]: fill [level:271] [W:5039 R:4769]
[14:53:55.898] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 2422 ms
[14:53:58.251] buffer_put_packet:612 [019B9810]: fill [level:708] [W:5476 R:4769]
[14:53:59.582] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 1875 ms
[14:54:03.285] buffer_put_packet:612 [019B9810]: fill [level:1227] [W:5995 R:4769]
[14:54:06.308] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 2891 ms
[14:54:06.547] buffer_put_packet:612 [019B9810]: fill [level:1739] [W:6507 R:4769]
[14:54:07.782] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 1047 ms
[14:54:15.542] buffer_put_packet:612 [019B9810]: fill [level:2280] [W:7048 R:4769]
[14:54:18.901] buffer_put_packet:612 [019B9810]: fill [level:3077] [W:7845 R:4769]
[14:54:21.129] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 9312 ms
[14:54:23.542] buffer_put_packet:612 [019B9810]: fill [level:3594] [W:8362 R:4769]
[14:54:23.982] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 7938 ms
[14:54:26.865] buffer_put_packet:612 [019B9810]: fill [level:4109] [W:8877 R:4769]
[14:54:27.320] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 6109 ms
[14:54:29.658] buffer_put_packet:612 [019B9810]: fill [level:4643] [W:9411 R:4769]
[14:54:34.314] buffer_put_packet:612 [019B9810]: fill [level:5186] [W:9954 R:4769]
[14:54:34.848] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 8750 ms
[14:54:39.269] buffer_put_packet:612 [019B9810]: fill [level:5783] [W:10551 R:4769]
[14:54:39.786] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 9266 ms
[14:54:40.569] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 6328 ms
[14:54:41.714] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 2312 ms
[14:54:43.345] buffer_put_packet:612 [019B9810]: fill [level:6357] [W:11125 R:4769]
[14:54:43.457] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:54:43.457] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 9

[14:54:46.983] buffer_put_packet:612 [019B9810]: fill [level:6811] [W:11579 R:4769]
[14:54:49.446] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 3859 ms
[14:54:50.664] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:54:50.664] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 11

[14:54:51.010] buffer_put_packet:612 [019B9810]: fill [level:7323] [W:12091 R:4769]
[14:54:53.476] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 3797 ms
[14:54:56.355] buffer_put_packet:612 [019B9810]: fill [level:7843] [W:12611 R:4769]
[14:54:59.300] buffer_put_packet:612 [019B9810]: fill [level:8358] [W:13126 R:4769]
[14:55:03.557] buffer_put_packet:612 [019B9810]: fill [level:8886] [W:13654 R:4769]
[14:55:07.633] buffer_put_packet:612 [019B9810]: fill [level:9399] [W:14167 R:4769]
[14:55:11.523] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 17907 ms
[14:55:12.682] buffer_put_packet:612 [019B9810]: fill [level:9920] [W:14688 R:4769]
[14:55:13.546] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:55:13.546] handle_rtsp:557 [01A6C1B0]: received metadata
artist: Calum Scott
album: Only Human (Deluxe)
title: Dancing On My Own
[14:55:13.561] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 13

[14:55:13.561] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 15844 ms
[14:55:15.113] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 9235 ms
[14:55:15.882] buffer_put_packet:612 [019B9810]: fill [level:10434] [W:15202 R:4769]
[14:55:18.045] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 5000 ms
[14:55:20.005] buffer_put_packet:612 [019B9810]: fill [level:10946] [W:15714 R:4769]
[14:55:22.827] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 5750 ms
[14:55:22.921] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 1297 ms
[14:55:23.684] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:55:23.684] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 15

[14:55:23.738] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:55:23.738] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 17

[14:55:23.800] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:55:23.800] handle_rtsp:557 [01A6C1B0]: received metadata
artist: Calum Scott
album: Only Human (Deluxe)
title: Dancing On My Own
[14:55:23.816] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 18

[14:55:24.050] buffer_put_packet:612 [019B9810]: fill [level:11458] [W:16226 R:4769]
[14:55:28.157] buffer_put_packet:612 [019B9810]: fill [level:11971] [W:16739 R:4769]
[14:55:32.220] buffer_put_packet:612 [019B9810]: fill [level:12483] [W:17251 R:4769]
[14:55:34.807] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 188 ms
[14:55:36.326] buffer_put_packet:612 [019B9810]: fill [level:12995] [W:17763 R:4769]
[14:55:40.435] buffer_put_packet:612 [019B9810]: fill [level:13509] [W:18277 R:4769]
[14:55:42.161] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 3563 ms
[14:55:45.109] buffer_put_packet:612 [019B9810]: fill [level:14044] [W:18812 R:4769]
[14:55:49.311] buffer_put_packet:612 [019B9810]: fill [level:14567] [W:19335 R:4769]
[14:55:50.770] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 4109 ms
[14:55:52.871] buffer_put_packet:612 [019B9810]: fill [level:15073] [W:19841 R:4769]
[14:55:52.918] rtp_thread_func:754 [019B9810]: discarding NTP roundtrip of 2187 ms
[14:55:57.228] buffer_put_packet:612 [019B9810]: fill [level:15583] [W:20351 R:4769]
[14:56:09.695] buffer_put_packet:612 [019B9810]: fill [level:16245] [W:21013 R:4769]
[14:56:10.433] buffer_put_packet:583 [019B9810] too many missing frames 291
[14:56:10.620] buffer_put_packet:612 [019B9810]: fill [level:17259] [W:22027 R:4769]
[14:56:13.129] buffer_put_packet:612 [019B9810]: fill [level:17609] [W:22377 R:4769]
[14:56:17.285] buffer_put_packet:612 [019B9810]: fill [level:18122] [W:22890 R:4769]
[14:56:21.314] buffer_put_packet:612 [019B9810]: fill [level:18633] [W:23401 R:4769]
[14:56:25.406] buffer_put_packet:612 [019B9810]: fill [level:19145] [W:23913 R:4769]
[14:56:29.483] buffer_put_packet:612 [019B9810]: fill [level:19657] [W:24425 R:4769]
[14:56:33.574] buffer_put_packet:612 [019B9810]: fill [level:20169] [W:24937 R:4769]
[14:56:37.632] buffer_put_packet:612 [019B9810]: fill [level:20681] [W:25449 R:4769]
[14:56:41.746] buffer_put_packet:612 [019B9810]: fill [level:21193] [W:25961 R:4769]
[14:56:45.837] buffer_put_packet:612 [019B9810]: fill [level:21706] [W:26474 R:4769]
[14:56:49.912] buffer_put_packet:612 [019B9810]: fill [level:22217] [W:26985 R:4769]
[14:56:53.992] buffer_put_packet:612 [019B9810]: fill [level:22729] [W:27497 R:4769]
[14:56:58.100] buffer_put_packet:612 [019B9810]: fill [level:23241] [W:28009 R:4769]
[14:57:02.174] buffer_put_packet:612 [019B9810]: fill [level:23753] [W:28521 R:4769]
[14:57:06.252] buffer_put_packet:612 [019B9810]: fill [level:24265] [W:29033 R:4769]
[14:57:10.345] buffer_put_packet:612 [019B9810]: fill [level:24777] [W:29545 R:4769]
[14:57:14.428] buffer_put_packet:612 [019B9810]: fill [level:25289] [W:30057 R:4769]
[14:57:18.592] buffer_put_packet:612 [019B9810]: fill [level:25803] [W:30571 R:4769]
[14:57:22.606] buffer_put_packet:612 [019B9810]: fill [level:26313] [W:31081 R:4769]
[14:57:25.885] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:25.885] handle_rtsp:557 [01A6C1B0]: received metadata
artist: ABBA
album: Super Trouper
title: Happy New Year
[14:57:25.885] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 72

[14:57:25.963] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:25.963] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 73

[14:57:26.092] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:26.092] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 74

[14:57:26.420] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:26.420] handle_rtsp:557 [01A6C1B0]: received metadata
artist: ABBA
album: Super Trouper
title: Happy New Year
[14:57:26.436] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 76

[14:57:26.451] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:26.451] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 77

[14:57:26.467] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:26.498] handle_rtsp:557 [01A6C1B0]: received metadata
artist: ABBA
album: Super Trouper
title: Happy New Year
[14:57:26.498] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 78

[14:57:26.685] buffer_put_packet:612 [019B9810]: fill [level:26825] [W:31593 R:4769]
[14:57:26.701] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:26.701] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 79

[14:57:30.289] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:30.289] handle_rtsp:557 [01A6C1B0]: received metadata
artist: ABBA
album: Super Trouper
title: Happy New Year
[14:57:30.307] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 82

[14:57:30.775] buffer_put_packet:612 [019B9810]: fill [level:27337] [W:32105 R:4769]
[14:57:30.885] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:30.885] handle_rtsp:557 [01A6C1B0]: received metadata
artist: ABBA
album: Super Trouper
title: Happy New Year
[14:57:30.885] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 83

[14:57:30.901] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:30.901] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 84

[14:57:31.653] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:31.653] handle_rtsp:557 [01A6C1B0]: received metadata
artist: Calum Scott
album: Only Human (Deluxe)
title: Dancing On My Own
[14:57:31.653] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 85

[14:57:31.668] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:31.668] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 86

[14:57:31.700] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:31.700] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 87

[14:57:32.172] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:32.172] handle_rtsp:557 [01A6C1B0]: received metadata
artist: Calum Scott
album: Only Human (Deluxe)
title: Dancing On My Own
[14:57:32.188] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 88

[14:57:32.203] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:32.203] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 89

[14:57:32.219] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:32.219] handle_rtsp:557 [01A6C1B0]: received metadata
artist: Calum Scott
album: Only Human (Deluxe)
title: Dancing On My Own
[14:57:32.219] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 90

[14:57:32.328] handle_rtsp:375 [01A6C1B0]: received SET_PARAMETER
[14:57:32.328] handle_rtsp:572 [01A6C1B0]: responding:
RTSP/1.0 200 OK
Audio-Jack-Status: connected; type=analog
CSeq: 92

[14:57:34.884] buffer_put_packet:612 [019B9810]: fill [level:27849] [W:32617 R:4769]
[14:57:36.043] handle_rtsp:375 [01A6C1B0]: received TEARDOWN
[14:57:36.105] rtp_thread_func:817 [019B9810]: terminating

@philippe44
Copy link
Owner

Try mp3 codec then

@philippe44
Copy link
Owner

philippe44 commented Jan 27, 2020

Closed for inactivity

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

3 participants