FDH2 / UxPlay

AirPlay Unix mirroring server
GNU General Public License v3.0
1.55k stars 78 forks source link

No window with mirror #1

Closed trin4ik closed 3 years ago

trin4ik commented 3 years ago
using randomly-generated MAC address 36:96:e1:c6:89:d7

Initialized server socket(s)
Accepted IPv4 client on socket 28
Local: 10.9.2.54
Remote: 10.9.2.5
Accepted IPv4 client on socket 31
Local: 10.9.2.54
Remote: 10.9.2.5

and no window started. looped on /feedback request

using randomly-generated MAC address 1e:87:19:30:20:0b

Initialized server socket(s)
Accepted IPv4 client on socket 24
Local: 10.9.2.54
Remote: 10.9.2.5
httpd receiving on socket 24
conn_request
Handling request GET with URL /info
INFO len = 297900300
httpd receiving on socket 24
conn_request
Handling request POST with URL /pair-setup
httpd receiving on socket 24
conn_request
Handling request POST with URL /pair-verify
httpd receiving on socket 24
conn_request
Handling request POST with URL /pair-verify
httpd receiving on socket 24
conn_request
Handling request POST with URL /fp-setup
httpd receiving on socket 24
conn_request
Handling request POST with URL /fp-setup
httpd receiving on socket 24
conn_request
Handling request SETUP with URL rtsp://10.9.2.54/2901359152534081471
DACP-ID: B857DEC4EF1349C5
Active-Remote: 2027036625
Transport: null
SETUP 1
eiv_len = 16
ekey_len = 72
fairplay_decrypt ret = 0
timing_rport = 61417
raop_ntp parse remote ip = 10.9.2.5
raop_ntp starting time
raop_rtp parse remote ip = 10.9.2.5
raop_rtp_mirror parse remote ip = 10.9.2.5
eport = 39133, tport = 52082
raop_ntp send_len = 32
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = -1628554502810687
Accepted IPv4 client on socket 31
Local: 10.9.2.54
Remote: 10.9.2.5
httpd receiving on socket 24
conn_request
Handling request GET with URL /info
INFO len = 297900300
httpd receiving on socket 24
conn_request
Handling request GET_PARAMETER with URL rtsp://10.9.2.54/2901359152534081471
httpd receiving on socket 24
conn_request
Handling request RECORD with URL rtsp://10.9.2.54/2901359152534081471
raop_handler_record
httpd receiving on socket 24
conn_request
Handling request SET_PARAMETER with URL rtsp://10.9.2.54/2901359152534081471
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_ntp send_len = 32
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = 0
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_ntp send_len = 32
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = 0
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_ntp send_len = 32
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = 0
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_ntp send_len = 32
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = 0
httpd receiving on socket 24
conn_request
Handling request POST with URL /feedback
fduncanh commented 3 years ago

Unfortunately the response to a "feedback" request is to do nothing, maybe it is waiting for a response. I hope it is caused by an earlier error that can be fixed.

what correct behavior would look like is shown below. It looks just like yours, except mine finishes with SETUP and the mirror starts, you go into the feedback loop.

  1. First try uxplay -d
    (no random mac)

  2. then uxplay -a -d
    (no audio)

just to see if anything there is involved.

3 Next: Can you help out by testing what happens when you run rpiplay -d

with rpiplay from https://github.com/FD-/RPiPlay

Conceivably I have broken something when updating raop in UxPlay to use the updated one from from RPiPlay.

correct behavior:

uxplay -m -d
using randomly-generated MAC address da:03:88:d1:bf:21

Initialized server socket(s)
Accepted IPv4 client on socket 29
Local: 10.9.2.20
Remote: 10.9.2.105
httpd receiving on socket 29
conn_request
Handling request GET with URL /info
INFO len = -1568688156
httpd receiving on socket 29
conn_request
Handling request POST with URL /pair-setup
httpd receiving on socket 29
conn_request
Handling request POST with URL /pair-verify
httpd receiving on socket 29
conn_request
Handling request POST with URL /pair-verify
httpd receiving on socket 29
conn_request
Handling request POST with URL /fp-setup
httpd receiving on socket 29
conn_request
Handling request POST with URL /fp-setup
httpd receiving on socket 29
conn_request
Handling request SETUP with URL rtsp://10.9.2.20/4463625837317541162
DACP-ID: D73F1B06F42CA9A1
Active-Remote: 695857077
Transport: null
SETUP 1
eiv_len = 16
ekey_len = 72
fairplay_decrypt ret = 0
timing_rport = 53688
raop_ntp parse remote ip = 10.9.2.105
raop_ntp starting time
raop_rtp parse remote ip = 10.9.2.105
raop_rtp_mirror parse remote ip = 10.9.2.105
eport = 46237, tport = 49542
raop_ntp send_len = 32
raop_ntp receive time type_t packetlen = 32
raop_ntp sync correction = -1628864724479237
Accepted IPv4 client on socket 31
Local: 10.9.2.20
Remote: 10.9.2.105
httpd receiving on socket 29
conn_request
Handling request GET with URL /info
INFO len = -1568688156
httpd receiving on socket 29
conn_request
Handling request GET_PARAMETER with URL rtsp://10.9.2.20/4463625837317541162
httpd receiving on socket 29
conn_request
Handling request RECORD with URL rtsp://10.9.2.20/4463625837317541162
raop_handler_record
httpd receiving on socket 29
conn_request
Handling request SET_PARAMETER with URL rtsp://10.9.2.20/4463625837317541162
httpd receiving on socket 29
conn_request
Handling request SETUP with URL rtsp://10.9.2.20/4463625837317541162
DACP-ID: D73F1B06F42CA9A1
Active-Remote: 695857077
Transport: null
type = 110
streamConnectionID = 3386794031239940106
raop_rtp_mirror starting mirroring
Mirroring initialized successfully
raop_rtp_mirror accepting client
raop_rtp_mirror width_source = 1296.000000 height_source = 972.000000 width = 1354.000000 height = 1016.000000
raop_rtp_mirror sps size = 17
raop_rtp_mirror pps size = 4
raop_rtp_mirror video ntp = 1628888772945221, now = 1628888772897340, latency = -47881
raop_rtp_mirror video ntp = 1628888772961888, now = 1628888772914321, latency = -47567
raop_rtp_mirror video ntp = 1628888773011824, now = 1628888772946951, latency = -64873
raop_rtp_mirror video ntp = 1628888773028491, now = 1628888772981741, latency = -46750
raop_rtp_mirror video ntp = 1628888773061793, now = 1628888772986994, latency = -74799
fduncanh commented 3 years ago

the feedback request also happen during normal working, so maybe it is normal when waiting for a reply

raop_rtp_mirror video ntp = 1628897805265803, now = 1628897805191180, latency = -74623
raop_rtp_mirror video ntp = 1628897805299120, now = 1628897805224571, latency = -74549
httpd receiving on socket 20
conn_request
Handling request POST with URL /feedback
raop_handler_feedback
raop_rtp_mirror video ntp = 1628897805332436, now = 1628897805257922, latency = -74514
raop_rtp_mirror video ntp = 1628897805665555, now = 1628897805591608, latency = -73947
raop_rtp_mirror video ntp = 1628897805698867, now = 1628897805624226, latency = -74641