soundsync
soundsync copied to clipboard
RSTP error when trying to connect to Sonos devices as Airplay devices
Sonos speakers show up as airplay devices once they are added, however on trying to link them, I get
Unknown Error: Error - RSTP error on ANNOUNCE (403 - Undefined)
I think this is related to the encrypted mode of Airplay which I haven't integrated yet. I don't have a Sonos device to test so this is just a guess. I'm going to look at how I can integrate the encrypted mode. I'll keep you posted
(To be fair, this may just be a Sonos problem, as I believe they do not support RSTP and only support older versions of the STP protocol)
https://en.community.sonos.com/advanced-setups-229000/will-sonos-s2-support-rstp-or-newer-stp-path-costs-6841084
This link doesn't seem to be talking about the same RSTP. The error Soundsync is sending is linked to the RTSP protocol used by Airplay (https://en.wikipedia.org/wiki/Real_Time_Streaming_Protocol) but this Sonos post is pointing to the Spanning Tree Protocol used in Ethernet networks.
Ah, well see, you already have a head start on me then!
I've integrated encrypted airplay streaming today. Can you try the latest dev version? (https://github.com/geekuillaume/soundsync/releases/tag/bleeding-edge)
Yes, will check this afternoon!
On Oct 6, 2020 at 10:05 AM, <Guillaume Besson (mailto:[email protected])> wrote:
I've integrated encrypted airplay streaming today. Can you try the latest dev version? (https://github.com/geekuillaume/soundsync/releases/tag/bleeding-edge)
— You are receiving this because you authored the thread. Reply to this email directly, view it on GitHub (https://github.com/geekuillaume/soundsync/issues/39#issuecomment-704334161), or unsubscribe (https://github.com/notifications/unsubscribe-auth/AA6WDDF63DIMHKRZ7X43TUDSJMW4ZANCNFSM4SFDQEKA).
Same error here. I can /kinda/sometimes get it to work if I set the sound output of a mac to a sonos speaker and then play to that mac, but not connecting directly.
Can report the same issue here, also tested with the bleeding-edge release.
Hope this is useful, but I found https://github.com/ejurgensen/forked-daapd/commit/a29772e8be962d1388d0403a36a94557b57334f9 which seems to solve the same issue. They report this is happening with Sonos ONE, Beam etc. I didn't dig into the actual code, but from the comment it seems like they don't actually try to encrypt/authenticate, but bypass the need to do so?
The purpose of auth-setup is to authenticate the device and to exchange keys for encryption. We don't do that, but some AirPlay 2 speakers (Sonos beam, Airport Express fw 7.8) require this step anyway, otherwise we get a 403 to our ANNOUNCE. So we do it with a flag for no encryption, and without actually authenticating the device.
I bought a Sonos speaker this week to test it. I was able to reproduce the problem and have been looking at foked-daapd code to understand how it works. I managed to connect successfully and send sound but it's very choppy and the sync is all over the place. It's working fine with forked-daapd so at least I have a working version to get some inspiration. I'll keep you posted once it's ready to be tested!
Good news everyone! I've managed to make Soundsync work with Sonos speakers through Airplay. The playback is good but the synchronization is broken (~500ms drift). I'm still working on this.
@gingerlime @estiens Can you try again with the last version of Soundsync and your speakers?
Hey @geekuillaume looks like it's working! that's great... Although it's not really perfect. Somehow it's a bit choppy / disconnects when playing to the Sonos via Airplay. Also had a crash. Anything I should debug/test?
If you have a crash can you get copy/paste the error message and stacktrace here?
will do if it happens again. But the crash is the least of my concerns at the moment... basically playback isn't really usable ... it kinda works, but it's not something my family can use to listen to music. It's too unreliable. I also tried soundsync on my pi using spotify as input and the browser as output (the built-in audio output does not seem to work at all, no clue why), and got some very funny-sounding output... the audio was distorted and pitch changed completely. Very odd... The situation isn't much better when running soundsync on my Macbook Air with Airplay input and output to Sonos. There's no distortion but the sound is choppy / pauses occasionally.
@gingerlime can you send the logs from the different devices you use?
How do I get the logs on Mac?
Here's the log from my pi ... I used a spotify input to play to the browser, and also to the analog output, and after a few seconds the sound was completely distorted
# /opt/Soundsync/soundsync
soundsync Starting soundsync +0ms
soundsync:wrtc Creating peer manager +0ms
soundsync:config Reading config from /root/.config/soundsync/config.json +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Created new peer +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Registering local peer with instaceUuid: 2bd08e1a-9ec5-48e6-91a7-81a4c9b05c2e +1ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae:peerInfo Received controller message {
type: 'peerInfo',
peer: {
uuid: 'c2984d96-6032-4111-9974-36aa7ac744ae',
name: 'raspberrypi',
instanceUuid: '2bd08e1a-9ec5-48e6-91a7-81a4c9b05c2e',
capacities: [
'librespot',
'http_server_accessible',
'hue',
'chromecast_interaction',
'shared_state_keeper',
'airplay_sink'
],
version: '0.4.5'
}
} +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Connected +0ms
soundsync:sourcesSinksManager Adding source Monitor of bcm2835 ALSA Analog Stereo of type localdevice +0ms
soundsync:audioSource:f1cd240a-d042-4c07-8b7b-90c738b7feb6 Created new audio source +0ms
soundsync:localAudioDevice Creating audio server +0ms
soundsync:localAudioDevice Created audio server +29ms
soundsync:sourcesSinksManager Adding sink bcm2835 ALSA Analog Stereo of type localdevice +53ms
soundsync:audioSink:e3f149f5-40e1-4678-bf16-95e0c92079a9 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Detecting local audio devices +8ms
soundsync:sourcesSinksManager Adding sink Built-in Audio Analog Mono of type localdevice +2ms
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Adding source Monitor of Built-in Audio Analog Mono of type localdevice +8ms
soundsync:audioSource:730aec8a-371e-4861-b667-82463ef55a50 Created new audio source +0ms
soundsync:httpserver Creating new http server +0ms
soundsync:httpserver Listening on 6512 +33ms
soundsync:httpserver Creating https server on 6513 +1ms
soundsync:rendezvous Registering to rendezvous service with: 192.168.0.99:6512_c2984d96-6032-4111-9974-36aa7ac744ae +0ms
soundsync:clientCoordinator Created client coordinator +0ms
soundsync:mdns Bound to address 192.168.0.99 and port 0 +0ms
soundsync:mdns Bound to address 0.0.0.0 and port 5353 +6ms
soundsync:peer:placeholderForHttpApiJoin_192.168.0.99:6512 Created new peer +0ms
soundsync:loopbackDeviceManager Created loopback interface +0ms
soundsync:peer:placeholderForHttpApiJoin_192.168.0.99:6512 Cannot connect to peer with initiator http api http initiator error: 409: Connecting to own peer +314ms
soundsync:sourcesSinksManager Detecting local audio devices +1s
soundsync:sourcesSinksManager Adding sink Soundsync of type localdevice +6ms
soundsync:audioSink:c4a2565d-3d11-4df5-a7a2-7f6edaa8c884 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Adding source Monitor of Soundsync of type localdevice +15ms
soundsync:audioSource:80579e37-6bdd-4312-8712-ecdc7a47c183 Created new audio source +0ms
soundsync:eventloop last 5 seconds: event loop blocked for 147.980287ms, mean: 11.330495063414633ms +0ms
soundsync:eventloop last 5 seconds: event loop blocked for 20.922367ms, mean: 10.144501593495935ms +10s
soundsync:eventloop last 5 seconds: event loop blocked for 28.622847ms, mean: 10.177571599182004ms +5s
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161 Created new peer +0ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161 Setting remote description +7ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161 Creating answer +11ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161 Setting local description +1ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161 Sending answer +3ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +0ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +3ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +998ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161:peerInfo Sending controller message {
type: 'peerInfo',
peer: {
uuid: 'c2984d96-6032-4111-9974-36aa7ac744ae',
name: 'raspberrypi',
instanceUuid: '2bd08e1a-9ec5-48e6-91a7-81a4c9b05c2e',
capacities: [
'librespot',
'http_server_accessible',
'hue',
'chromecast_interaction',
'shared_state_keeper',
'airplay_sink'
],
version: '0.4.5'
},
sharedState: { hueBridges: [], lastUpdateTimestamp: -1 }
} +0ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_383a77ac-3b56-4ff7-85d1-63b242554161:peerInfo Received controller message {
type: 'peerInfo',
peer: {
uuid: '7333b954-1f43-439a-a64c-ec997cdc9327',
name: 'Web page',
instanceUuid: 'da27f38c-64f0-44bf-8257-7fe8bddd73d6',
capacities: [],
version: '0.4.5'
}
} +17ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Connected +0ms
soundsync:sourcesSinksManager Adding sink Web Page Output of type webaudio +32s
soundsync:audioSink:6d22ee27-0f4b-4348-87c6-46bad167f86b Created new audio sink of type webaudio +0ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Updating timedelta to -32247.917468501255, diff: -32247.92ms +332ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +3s
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:eventloop last 5 seconds: event loop blocked for 115.408895ms, mean: 11.761325886792452ms +15s
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +1s
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +1ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +1s
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +3s
soundsync:mdns Received mdns request for 383a77ac3b564ff785d163b2425541612984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:eventloop last 5 seconds: event loop blocked for 24.313855ms, mean: 10.35089856133056ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 20.856831ms, mean: 10.195513586912066ms +5s
^C soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae:disconnect Received controller message { type: 'disconnect' } +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Destroying peer, reason: exiting +1m
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327:disconnect Sending controller message { type: 'disconnect' } +0ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Destroying peer, reason: exiting +37s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Cleaning webrtc state +2ms
Connection failure: Connection refused
pa_context_connect() failed: Connection refused
root@raspberrypi:~# systemctl stop shairport-sync.service
root@raspberrypi:~# /opt/Soundsync/soundsync
soundsync Starting soundsync +0ms
soundsync:wrtc Creating peer manager +0ms
soundsync:config Reading config from /root/.config/soundsync/config.json +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Created new peer +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Registering local peer with instaceUuid: d348a812-0c31-4f91-a56d-e014590abdcc +1ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae:peerInfo Received controller message {
type: 'peerInfo',
peer: {
uuid: 'c2984d96-6032-4111-9974-36aa7ac744ae',
name: 'raspberrypi',
instanceUuid: 'd348a812-0c31-4f91-a56d-e014590abdcc',
capacities: [
'librespot',
'http_server_accessible',
'hue',
'chromecast_interaction',
'shared_state_keeper',
'airplay_sink'
],
version: '0.4.5'
}
} +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Connected +0ms
soundsync:sourcesSinksManager Adding source Monitor of Built-in Audio Analog Mono of type localdevice +0ms
soundsync:audioSource:730aec8a-371e-4861-b667-82463ef55a50 Created new audio source +0ms
soundsync:localAudioDevice Creating audio server +0ms
soundsync:localAudioDevice Created audio server +29ms
soundsync:sourcesSinksManager Adding source Monitor of Soundsync of type localdevice +46ms
soundsync:audioSource:80579e37-6bdd-4312-8712-ecdc7a47c183 Created new audio source +0ms
soundsync:sourcesSinksManager Adding source Monitor of bcm2835 ALSA Analog Stereo of type localdevice +12ms
soundsync:audioSource:f1cd240a-d042-4c07-8b7b-90c738b7feb6 Created new audio source +0ms
soundsync:sourcesSinksManager Adding sink Soundsync of type localdevice +8ms
soundsync:audioSink:c4a2565d-3d11-4df5-a7a2-7f6edaa8c884 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Adding sink Built-in Audio Analog Mono of type localdevice +8ms
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Adding sink bcm2835 ALSA Analog Stereo of type localdevice +6ms
soundsync:audioSink:e3f149f5-40e1-4678-bf16-95e0c92079a9 Created new audio sink of type localdevice +0ms
soundsync:sourcesSinksManager Detecting local audio devices +4ms
soundsync:httpserver Creating new http server +0ms
soundsync:httpserver Listening on 6512 +32ms
soundsync:httpserver Creating https server on 6513 +0ms
soundsync:rendezvous Registering to rendezvous service with: 192.168.0.99:6512_c2984d96-6032-4111-9974-36aa7ac744ae +0ms
soundsync:clientCoordinator Created client coordinator +0ms
soundsync:mdns Bound to address 192.168.0.99 and port 0 +0ms
soundsync:mdns Bound to address 0.0.0.0 and port 5353 +6ms
soundsync:peer:placeholderForHttpApiJoin_192.168.0.99:6512 Created new peer +0ms
soundsync:loopbackDeviceManager Created loopback interface +0ms
soundsync:peer:placeholderForHttpApiJoin_192.168.0.99:6512 Cannot connect to peer with initiator http api http initiator error: 409: Connecting to own peer +325ms
soundsync:sourcesSinksManager Detecting local audio devices +1s
soundsync:eventloop last 5 seconds: event loop blocked for 160.301055ms, mean: 11.263047903147699ms +0ms
soundsync:eventloop last 5 seconds: event loop blocked for 25.444351ms, mean: 10.128687869918698ms +5s
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538 Created new peer +0ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538 Setting remote description +7ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538 Creating answer +9ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538 Setting local description +2ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538 Sending answer +3ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +0ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +4ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +1s
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538:peerInfo Sending controller message {
type: 'peerInfo',
peer: {
uuid: 'c2984d96-6032-4111-9974-36aa7ac744ae',
name: 'raspberrypi',
instanceUuid: 'd348a812-0c31-4f91-a56d-e014590abdcc',
capacities: [
'librespot',
'http_server_accessible',
'hue',
'chromecast_interaction',
'shared_state_keeper',
'airplay_sink'
],
version: '0.4.5'
},
sharedState: { hueBridges: [], lastUpdateTimestamp: -1 }
} +0ms
soundsync:peer:placeholderForRendezvousInitiatorRequest_7b5a2884-b3bd-47f1-a37d-0a50be4bd538:peerInfo Received controller message {
type: 'peerInfo',
peer: {
uuid: '7333b954-1f43-439a-a64c-ec997cdc9327',
name: 'Web page',
instanceUuid: 'a105135a-0189-426e-925c-9dbc05084716',
capacities: [],
version: '0.4.5'
}
} +20ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Connected +0ms
soundsync:sourcesSinksManager Adding sink Web Page Output of type webaudio +14s
soundsync:audioSink:6d22ee27-0f4b-4348-87c6-46bad167f86b Created new audio sink of type webaudio +0ms
soundsync:eventloop last 5 seconds: event loop blocked for 91.422719ms, mean: 11.634199925233645ms +5s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Updating timedelta to -13515.591401500627, diff: -13515.59ms +320ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +3s
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +960ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +4ms
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +1s
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +3ms
soundsync:eventloop last 5 seconds: event loop blocked for 35.553279ms, mean: 10.493666835443038ms +5s
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +3s
soundsync:mdns Received mdns request for 7b5a2884b3bd47f1a37d0a50be4bd5382984d9660324111997436aa7ac744ae.local, handling initiator notification +2ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327:sourceCreate Received controller message {
type: 'sourceCreate',
source: {
type: 'librespot',
name: 'Spotify on Pi',
peerUuid: 'c2984d96-6032-4111-9974-36aa7ac744ae',
uuid: 'b3d8d7ee-3bf6-499f-b3c6-2ac90830aada',
librespotOptions: { name: 'Spotify on Pi' }
}
} +0ms
soundsync:sourcesSinksManager Adding source Spotify on Pi of type librespot +30s
soundsync:audioSource:b3d8d7ee-3bf6-499f-b3c6-2ac90830aada Created new audio source +0ms
soundsync:audioSource:b3d8d7ee-3bf6-499f-b3c6-2ac90830aada Starting audio source +5ms
soundsync:depsDownloader Ensuring dep librespot at /root/.config/soundsync/librespot +0ms
soundsync:depsDownloader Dep is not suitable, downloading from https://github.com/geekuillaume/librespot/releases/download/v0.1.2/librespot-linux-arm-featureless ENOENT: no such file or directory, open '/root/.config/soundsync/librespot' +10ms
soundsync:eventloop last 5 seconds: event loop blocked for 52.297727ms, mean: 10.330968513457558ms +25s
soundsync:depsDownloader Downloaded dep to /root/.config/soundsync/librespot +4s
soundsync:audioSource:b3d8d7ee-3bf6-499f-b3c6-2ac90830aada Starting librespot process +4s
soundsync:eventloop last 5 seconds: event loop blocked for 103.743487ms, mean: 12.74348358056266ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 24.592383ms, mean: 10.215558020449897ms +15s
soundsync:eventloop last 5 seconds: event loop blocked for 23.461887ms, mean: 10.218191112936346ms +5s
Stream started again
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Received request for source b3d8d7ee-3bf6-499f-b3c6-2ac90830aada +1m
soundsync:eventloop last 5 seconds: event loop blocked for 240.254975ms, mean: 18.430087032967034ms +10s
soundsync:eventloop last 5 seconds: event loop blocked for 44.236799ms, mean: 19.14898116923077ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 34.996223ms, mean: 14.231236022857143ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 65.732607ms, mean: 16.973733442176872ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 27.672575ms, mean: 13.68827076923077ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 31.064063ms, mean: 13.636949333333334ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 27.852799ms, mean: 13.931256849162011ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 35.094527ms, mean: 13.656814465753424ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 25.870335ms, mean: 13.673823648351648ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 28.950527ms, mean: 13.81083367955801ms +5s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327:sinkPatch Received controller message {
type: 'sinkPatch',
sink: {
uuid: 'c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3',
instanceUuid: '770814ad-a415-49c3-b6af-626c219c0a68',
pipedFrom: 'b3d8d7ee-3bf6-499f-b3c6-2ac90830aada'
}
} +0ms
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Linking audio source Spotify on Pi (uuid b3d8d7ee-3bf6-499f-b3c6-2ac90830aada) to sink +2m
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Starting localdevice sink +4ms
soundsync:eventloop last 5 seconds: event loop blocked for 47.284223ms, mean: 14.34371172334294ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 34.635775ms, mean: 14.329885510086454ms +5s
soundsync:eventloop last 5 seconds: event loop blocked for 32.948223ms, mean: 14.640878253687317ms +5s
Stream out of data, stopping reading loop until new data arrives
soundsync:eventloop last 5 seconds: event loop blocked for 37.552127ms, mean: 13.592448699453552ms +5s
Stream started again
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Received old chunk, discarding it: 9958, current playing chunk is 11232 +30s
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Received old chunk, discarding it: 9959, current playing chunk is 11232 +1ms
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Received out-of-order chunk, received chunk index: 11231, last chunk index: 9959 +15ms
soundsync:eventloop last 5 seconds: event loop blocked for 21.987327ms, mean: 10.399658666666665ms +30s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Received request for source b3d8d7ee-3bf6-499f-b3c6-2ac90830aada +2m
soundsync:eventloop last 5 seconds: event loop blocked for 34.766847ms, mean: 14.27627008ms +15s
Stream out of data, stopping reading loop until new data arrives
soundsync:eventloop last 5 seconds: event loop blocked for 36.208639ms, mean: 14.229967725714285ms +5s
^C soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae:disconnect Received controller message { type: 'disconnect' } +0ms
soundsync:peer:c2984d96-6032-4111-9974-36aa7ac744ae Destroying peer, reason: exiting +4m
soundsync:audioSink:c4a319c8-a1b6-4fb9-b5fc-421e7d5188a3 Source stream has closed, unlinking +58s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327:disconnect Sending controller message { type: 'disconnect' } +0ms
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Destroying peer, reason: exiting +30s
soundsync:peer:7333b954-1f43-439a-a64c-ec997cdc9327 Cleaning webrtc state +2ms
Connection failure: Connection refused
pa_context_connect() failed: Connection refused
I've added a simpler way to get the logs in the last version of Soundsync. Can you update, get the logs from http://127.0.0.1:6512/debuginfo and send them here?
Here's one try at getting a few different sources to play on various Sonos speakers (couldn't get any sound out of them this time)
{
"version":"0.4.7",
"platform":"darwin",
"arch":"x64",
"logs":[
"2020-10-23T17:50:59.965Z soundsync Starting soundsync",
"2020-10-23T17:50:59.971Z soundsync:wrtc Creating peer manager",
"2020-10-23T17:50:59.972Z soundsync:config Reading config from /Users/estiens/Library/Preferences/soundsync/config.json",
"2020-10-23T17:50:59.974Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407 Created new peer",
"2020-10-23T17:50:59.974Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407 Registering local peer with instaceUuid: 875aa239-edc3-4c64-a5b8-59440753503a",
"2020-10-23T17:50:59.974Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407:peerInfo Received controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n name: 'RacemicCeramic.local',\n instanceUuid: '875aa239-edc3-4c64-a5b8-59440753503a',\n capacities: [\n 'librespot',\n 'shairport',\n 'http_server_accessible',\n 'hue',\n 'chromecast_interaction',\n 'shared_state_keeper',\n 'airplay_sink'\n ],\n version: '0.4.7'\n }\n}",
"2020-10-23T17:50:59.976Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407 Connected",
"2020-10-23T17:50:59.977Z soundsync:sourcesSinksManager Detecting local audio devices",
"2020-10-23T17:50:59.977Z soundsync:localAudioDevice Creating audio server",
"2020-10-23T17:51:00.021Z soundsync:localAudioDevice Created audio server",
"2020-10-23T17:51:00.028Z soundsync:sourcesSinksManager Adding sink BlackHole 2ch of type localdevice",
"2020-10-23T17:51:00.029Z soundsync:audioSink:49bc6fff-a61b-43dd-a645-1cbdfa1405f7 Created new audio sink of type localdevice",
"2020-10-23T17:51:00.031Z soundsync:sourcesSinksManager Adding sink BlackHole 16ch of type localdevice",
"2020-10-23T17:51:00.032Z soundsync:audioSink:bf6cc3d7-efa1-419e-af47-7cc79c5cae40 Created new audio sink of type localdevice",
"2020-10-23T17:51:00.033Z soundsync:sourcesSinksManager Adding sink MacBook Pro Speakers of type localdevice",
"2020-10-23T17:51:00.033Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Created new audio sink of type localdevice",
"2020-10-23T17:51:00.034Z soundsync:sourcesSinksManager Adding source BlackHole 2ch of type localdevice",
"2020-10-23T17:51:00.034Z soundsync:audioSource:ebef74cd-6b18-49e4-a256-9d0fdd23fdc7 Created new audio source",
"2020-10-23T17:51:00.035Z soundsync:sourcesSinksManager Adding source BlackHole 16ch of type localdevice",
"2020-10-23T17:51:00.035Z soundsync:audioSource:1abe467b-fb0f-405c-97d0-16cce1ffe0d5 Created new audio source",
"2020-10-23T17:51:00.036Z soundsync:sourcesSinksManager Adding source MacBook Pro Microphone of type localdevice",
"2020-10-23T17:51:00.036Z soundsync:audioSource:3448a68c-907e-4b10-9370-8358ec0689e2 Created new audio source",
"2020-10-23T17:51:00.036Z soundsync:sourcesSinksManager Adding source Loopback 4 of type localdevice",
"2020-10-23T17:51:00.036Z soundsync:audioSource:09ed31e2-d1ff-4d6c-a862-5c71f23b82ed Created new audio source",
"2020-10-23T17:51:00.039Z soundsync:httpserver Creating new http server",
"2020-10-23T17:51:00.045Z soundsync:httpserver Listening on 6512",
"2020-10-23T17:51:00.045Z soundsync:httpserver Creating https server on 6513",
"2020-10-23T17:51:00.058Z soundsync:rendezvous Registering to rendezvous service with: 192.168.68.108:6512_deb6e192-1531-4711-a8cc-f5bf23003407",
"2020-10-23T17:51:00.061Z soundsync:loopbackDeviceManager Loopback interface creation not supported on audiounit-rust",
"2020-10-23T17:51:00.061Z soundsync:clientCoordinator Created client coordinator",
"2020-10-23T17:51:00.069Z soundsync:mdns Bound to address 192.168.68.108 and port 0",
"2020-10-23T17:51:00.070Z soundsync:mdns Bound to address 0.0.0.0 and port 5353",
"2020-10-23T17:51:00.174Z soundsync:updater Updater starting, current version: 0.4.7",
"2020-10-23T17:51:00.175Z soundsync:updater Checking for update",
"2020-10-23T17:51:00.242Z soundsync:updater Generated new staging user ID: f3a155dd-b480-550f-98c5-d89b8a8df94d",
"2020-10-23T17:51:01.038Z soundsync:peer:placeholderForHttpApiJoin_fe80::1450:320e:8dd3:8f26:6512 Created new peer",
"2020-10-23T17:51:01.104Z soundsync:peer:placeholderForHttpApiJoin_fe80::1450:320e:8dd3:8f26:6512 Cannot connect to peer with initiator http api getaddrinfo ENOTFOUND fe80",
"2020-10-23T17:51:01.448Z soundsync:updater Update for version 0.4.7 is not available (latest version: 0.4.7, downgrade is disallowed).",
"2020-10-23T17:51:04.233Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11 Created new peer",
"2020-10-23T17:51:04.234Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11 Setting remote description",
"2020-10-23T17:51:04.236Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11 Creating answer",
"2020-10-23T17:51:04.236Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11 Setting local description",
"2020-10-23T17:51:04.237Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11 Sending answer",
"2020-10-23T17:51:04.410Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:04.410Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:04.965Z soundsync:eventloop last 5 seconds: event loop blocked for 152.829951ms, mean: 11.752953831325302ms",
"2020-10-23T17:51:05.515Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:05.515Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:06.714Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11:peerInfo Sending controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n name: 'RacemicCeramic.local',\n instanceUuid: '875aa239-edc3-4c64-a5b8-59440753503a',\n capacities: [\n 'librespot',\n 'shairport',\n 'http_server_accessible',\n 'hue',\n 'chromecast_interaction',\n 'shared_state_keeper',\n 'airplay_sink'\n ],\n version: '0.4.7'\n },\n sharedState: { hueBridges: [], lastUpdateTimestamp: -1 }\n}",
"2020-10-23T17:51:06.727Z soundsync:peer:placeholderForRendezvousInitiatorRequest_6ed550f6-303b-4dec-ad30-8189f012dd11:peerInfo Received controller message {\n type: 'peerInfo',\n peer: {\n uuid: '6d4a173b-7815-4a95-aeae-a697faffd9ec',\n name: 'Web page',\n instanceUuid: '175ca4f1-a814-4290-a0ce-a01b9c4e0947',\n capacities: [],\n version: '0.4.7'\n }\n}",
"2020-10-23T17:51:06.728Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec Connected",
"2020-10-23T17:51:06.730Z soundsync:sourcesSinksManager Adding sink Web Page Output of type webaudio",
"2020-10-23T17:51:06.730Z soundsync:audioSink:e6b7f6cb-9eeb-456b-b6be-40f75e3b6344 Created new audio sink of type webaudio",
"2020-10-23T17:51:07.036Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec Updating timedelta to -1807.9950485229492, diff: -1808.00ms",
"2020-10-23T17:51:07.699Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:07.699Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:09.303Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:09.303Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:10.307Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:10.308Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:13.317Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:13.318Z soundsync:mdns Received mdns request for 6ed550f6303b4decad308189f012dd11eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T17:51:22.392Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'scanAirplay',\n isResponse: false,\n uuid: 'a0547213-620a-461e-9d0d-08dc83eb8081'\n}",
"2020-10-23T17:51:22.950Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: [\n {\n host: '192.168.68.121',\n name: '347E5CD299D4@Sunroom',\n port: 7000\n },\n {\n host: '192.168.68.127',\n name: '48A6B8AA653A@Bathroom',\n port: 7000\n },\n {\n host: '192.168.68.126',\n name: '48A6B8AA723E@Entryway',\n port: 7000\n },\n {\n host: '192.168.68.102',\n name: '949F3ED5AF7F@Bedroom',\n port: 7000\n }\n ],\n uuid: 'a0547213-620a-461e-9d0d-08dc83eb8081',\n rpcType: 'scanAirplay'\n}",
"2020-10-23T17:51:25.392Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'scanAirplay',\n isResponse: false,\n uuid: 'e2f451cf-6c64-4c0e-a828-7c4d39ea639c'\n}",
"2020-10-23T17:51:25.392Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: [\n {\n host: '192.168.68.121',\n name: '347E5CD299D4@Sunroom',\n port: 7000\n },\n {\n host: '192.168.68.127',\n name: '48A6B8AA653A@Bathroom',\n port: 7000\n },\n {\n host: '192.168.68.126',\n name: '48A6B8AA723E@Entryway',\n port: 7000\n },\n {\n host: '192.168.68.102',\n name: '949F3ED5AF7F@Bedroom',\n port: 7000\n }\n ],\n uuid: 'e2f451cf-6c64-4c0e-a828-7c4d39ea639c',\n rpcType: 'scanAirplay'\n}",
"2020-10-23T17:51:28.264Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'createSink',\n isResponse: false,\n body: {\n type: 'airplay',\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n available: true,\n name: '347E5CD299D4@Sunroom',\n volume: 1,\n peerUuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n pipedFrom: null,\n host: '192.168.68.121',\n port: 7000\n },\n uuid: '2466fffe-893f-4e8f-9864-1130be5e8376'\n}",
"2020-10-23T17:51:28.264Z soundsync:sourcesSinksManager Adding sink 347E5CD299D4@Sunroom of type airplay",
"2020-10-23T17:51:28.265Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Created new audio sink of type airplay",
"2020-10-23T17:51:28.268Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: undefined,\n uuid: '2466fffe-893f-4e8f-9864-1130be5e8376',\n rpcType: 'createSink'\n}",
"2020-10-23T17:52:04.974Z soundsync:eventloop last 5 seconds: event loop blocked for 26.443775ms, mean: 11.61151075058275ms",
"2020-10-23T17:52:14.975Z soundsync:eventloop last 5 seconds: event loop blocked for 131.465215ms, mean: 11.85898048456057ms",
"2020-10-23T17:52:19.976Z soundsync:eventloop last 5 seconds: event loop blocked for 24.559615ms, mean: 11.691154285714285ms",
"2020-10-23T17:53:04.981Z soundsync:eventloop last 5 seconds: event loop blocked for 29.884415ms, mean: 11.70205137236534ms",
"2020-10-23T17:53:08.336Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: 'ebef74cd-6b18-49e4-a256-9d0fdd23fdc7'\n }\n}",
"2020-10-23T17:53:08.338Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407:rpc Received controller message {\n type: 'rpc',\n rpcType: 'startSource',\n isResponse: false,\n body: 'ebef74cd-6b18-49e4-a256-9d0fdd23fdc7',\n uuid: 'd0c6e35a-5dc3-46a6-81d8-557c8fb9298a'\n}",
"2020-10-23T17:53:08.338Z soundsync:audioSource:ebef74cd-6b18-49e4-a256-9d0fdd23fdc7 Starting audio source",
"2020-10-23T17:53:08.340Z soundsync:audioSource:ebef74cd-6b18-49e4-a256-9d0fdd23fdc7 Creating localdevice source",
"2020-10-23T17:53:08.408Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407:rpc Received controller message {\n type: 'rpc',\n isResponse: true,\n body: undefined,\n uuid: 'd0c6e35a-5dc3-46a6-81d8-557c8fb9298a',\n rpcType: 'startSource'\n}",
"2020-10-23T17:53:08.489Z soundsync:audioSinkDebug Stream started again",
"2020-10-23T17:53:08.551Z soundsync:audioSinkDebug Stream out of data, stopping reading loop until new data arrives",
"2020-10-23T17:53:08.590Z soundsync:audioSinkDebug Stream started again",
"2020-10-23T17:53:08.591Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Linking audio source BlackHole 2ch (uuid ebef74cd-6b18-49e4-a256-9d0fdd23fdc7) to sink",
"2020-10-23T17:53:08.592Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Connecting to Airplay sink",
"2020-10-23T17:53:08.610Z soundsync:rtsp Connecting to 192.168.68.121:7000",
"2020-10-23T17:53:08.616Z soundsync:rtsp Connected",
"2020-10-23T17:53:08.617Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nApple-Challenge: yEzsIKzeAwcobuhqWEkIzQ==",
"2020-10-23T17:53:08.626Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T17:53:09.070Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nContent-Type: application/sdp\r\nContent-Length: 186\r\n\r\nv=0\r\no=iTunes 1308230407 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.121\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T17:53:09.076Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5145;timing_port=6968",
"2020-10-23T17:53:09.106Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nSession: 1\r\nRTP-Info: seq=1123;rtptime=395438",
"2020-10-23T17:53:09.114Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T17:53:09.119Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0",
"2020-10-23T17:53:09.981Z soundsync:eventloop last 5 seconds: event loop blocked for 80.936959ms, mean: 11.743887359999999ms",
"2020-10-23T17:54:04.990Z soundsync:eventloop last 5 seconds: event loop blocked for 32.718847ms, mean: 11.565899851851853ms",
"2020-10-23T17:54:24.993Z soundsync:eventloop last 5 seconds: event loop blocked for 30.916607ms, mean: 11.475636082758621ms",
"2020-10-23T17:54:44.811Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: 'ebef74cd-6b18-49e4-a256-9d0fdd23fdc7'\n }\n}",
"2020-10-23T17:54:44.814Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Linking audio source BlackHole 2ch (uuid ebef74cd-6b18-49e4-a256-9d0fdd23fdc7) to sink",
"2020-10-23T17:54:44.815Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Starting localdevice sink",
"2020-10-23T17:54:44.826Z soundsync:synchronizedAudioBuffer = hard sync: 1783.4375ms",
"2020-10-23T17:54:49.823Z soundsync:synchronizedAudioBuffer = soft sync: -52.8125ms (-2535 samples), injecting -9 samples now",
"2020-10-23T17:54:52.807Z soundsync:synchronizedAudioBuffer = finished delayed soft drift correction",
"2020-10-23T17:54:58.157Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: null\n }\n}",
"2020-10-23T17:54:58.159Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Source stream has closed, unlinking",
"2020-10-23T17:54:59.837Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: null\n }\n}",
"2020-10-23T17:54:59.838Z soundsync:rtsp Sending TEARDOWN rtsp://192.168.68.108/1308230407 RTSP/1.0\r\nCSeq: 8\r\nUser-Agent: Soundsync\r\nDACP-ID: 1308230407\r\nClient-Instance: 1308230407\r\nSession: 1",
"2020-10-23T17:54:59.838Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Source stream has closed, unlinking",
"2020-10-23T17:54:59.996Z soundsync:eventloop last 5 seconds: event loop blocked for 28.999679ms, mean: 11.154697142857144ms",
"2020-10-23T17:55:04.998Z soundsync:eventloop last 5 seconds: event loop blocked for 32.325631ms, mean: 11.663815644028103ms",
"2020-10-23T17:55:32.887Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sourceCreate Received controller message {\n type: 'sourceCreate',\n source: {\n type: 'librespot',\n name: 'Spotify on Soundsync',\n peerUuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n uuid: 'c6c6d555-0754-48f5-a637-695cee6aec9e',\n librespotOptions: { name: 'Spotify on Soundsync' }\n }\n}",
"2020-10-23T17:55:32.888Z soundsync:sourcesSinksManager Adding source Spotify on Soundsync of type librespot",
"2020-10-23T17:55:32.888Z soundsync:audioSource:c6c6d555-0754-48f5-a637-695cee6aec9e Created new audio source",
"2020-10-23T17:55:32.889Z soundsync:audioSource:c6c6d555-0754-48f5-a637-695cee6aec9e Starting audio source",
"2020-10-23T17:55:32.892Z soundsync:depsDownloader Ensuring dep librespot at /Users/estiens/Library/Preferences/soundsync/librespot",
"2020-10-23T17:55:32.894Z soundsync:depsDownloader Dep is not suitable, downloading from https://github.com/geekuillaume/librespot/releases/download/v0.1.2/librespot-macos-x64-featureless ENOENT: no such file or directory, open '/Users/estiens/Library/Preferences/soundsync/librespot'",
"2020-10-23T17:55:34.066Z soundsync:depsDownloader Downloaded dep to /Users/estiens/Library/Preferences/soundsync/librespot",
"2020-10-23T17:55:34.066Z soundsync:audioSource:c6c6d555-0754-48f5-a637-695cee6aec9e Starting librespot process",
"2020-10-23T17:55:35.003Z soundsync:eventloop last 5 seconds: event loop blocked for 34.373631ms, mean: 11.437009027522937ms",
"2020-10-23T17:55:36.811Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: 'c6c6d555-0754-48f5-a637-695cee6aec9e'\n }\n}",
"2020-10-23T17:55:45.007Z soundsync:eventloop last 5 seconds: event loop blocked for 36.667391ms, mean: 11.631780699300698ms",
"2020-10-23T17:56:05.009Z soundsync:eventloop last 5 seconds: event loop blocked for 30.212095ms, mean: 11.610435869767443ms",
"2020-10-23T17:56:20.011Z soundsync:eventloop last 5 seconds: event loop blocked for 32.358399ms, mean: 11.595480706976744ms",
"2020-10-23T17:56:25.759Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'scanAirplay',\n isResponse: false,\n uuid: '2619cbe6-7fb9-4c64-a8e5-ca2b9b2b7519'\n}",
"2020-10-23T17:56:25.759Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: [\n {\n host: '192.168.68.121',\n name: '347E5CD299D4@Sunroom',\n port: 7000\n },\n {\n host: '192.168.68.127',\n name: '48A6B8AA653A@Bathroom',\n port: 7000\n },\n {\n host: '192.168.68.126',\n name: '48A6B8AA723E@Entryway',\n port: 7000\n },\n {\n host: '192.168.68.102',\n name: '949F3ED5AF7F@Bedroom',\n port: 7000\n }\n ],\n uuid: '2619cbe6-7fb9-4c64-a8e5-ca2b9b2b7519',\n rpcType: 'scanAirplay'\n}",
"2020-10-23T17:56:28.763Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'scanAirplay',\n isResponse: false,\n uuid: '8cac651b-b8f5-47b0-99d5-89085437cf3d'\n}",
"2020-10-23T17:56:28.764Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: [\n {\n host: '192.168.68.121',\n name: '347E5CD299D4@Sunroom',\n port: 7000\n },\n {\n host: '192.168.68.127',\n name: '48A6B8AA653A@Bathroom',\n port: 7000\n },\n {\n host: '192.168.68.126',\n name: '48A6B8AA723E@Entryway',\n port: 7000\n },\n {\n host: '192.168.68.102',\n name: '949F3ED5AF7F@Bedroom',\n port: 7000\n }\n ],\n uuid: '8cac651b-b8f5-47b0-99d5-89085437cf3d',\n rpcType: 'scanAirplay'\n}",
"2020-10-23T17:56:29.737Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Received controller message {\n type: 'rpc',\n rpcType: 'createSink',\n isResponse: false,\n body: {\n type: 'airplay',\n uuid: 'be1e3939-ac9d-43b6-96fa-915e2c3f34e2',\n available: true,\n name: '48A6B8AA723E@Entryway',\n volume: 1,\n peerUuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n pipedFrom: null,\n host: '192.168.68.126',\n port: 7000\n },\n uuid: 'fe0112a1-8b31-4331-b0d2-ebaad2ae42fd'\n}",
"2020-10-23T17:56:29.738Z soundsync:sourcesSinksManager Adding sink 48A6B8AA723E@Entryway of type airplay",
"2020-10-23T17:56:29.738Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Created new audio sink of type airplay",
"2020-10-23T17:56:29.741Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:rpc Sending controller message {\n type: 'rpc',\n isResponse: true,\n body: undefined,\n uuid: 'fe0112a1-8b31-4331-b0d2-ebaad2ae42fd',\n rpcType: 'createSink'\n}",
"2020-10-23T17:56:36.890Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: null\n }\n}",
"2020-10-23T17:56:39.232Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: 'ebef74cd-6b18-49e4-a256-9d0fdd23fdc7'\n }\n}",
"2020-10-23T17:56:39.233Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Linking audio source BlackHole 2ch (uuid ebef74cd-6b18-49e4-a256-9d0fdd23fdc7) to sink",
"2020-10-23T17:56:39.234Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Connecting to Airplay sink",
"2020-10-23T17:56:39.254Z soundsync:rtsp Connecting to 192.168.68.121:7000",
"2020-10-23T17:56:39.259Z soundsync:rtsp Connected",
"2020-10-23T17:56:39.261Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nApple-Challenge: CEw2jjm5FGpgbZZ7UIUG9Q==",
"2020-10-23T17:56:39.268Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T17:56:39.698Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nContent-Type: application/sdp\r\nContent-Length: 186\r\n\r\nv=0\r\no=iTunes 2844575990 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.121\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T17:56:39.706Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5202;timing_port=6112",
"2020-10-23T17:56:39.754Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nSession: 1\r\nRTP-Info: seq=27514;rtptime=9685126",
"2020-10-23T17:56:39.758Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T17:56:39.766Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0",
"2020-10-23T17:56:40.011Z soundsync:eventloop last 5 seconds: event loop blocked for 23.937023ms, mean: 11.461832091954022ms",
"2020-10-23T17:56:50.012Z soundsync:eventloop last 5 seconds: event loop blocked for 33.357823ms, mean: 11.570157037037037ms",
"2020-10-23T17:57:05.016Z soundsync:eventloop last 5 seconds: event loop blocked for 33.783807ms, mean: 11.65954153271028ms",
"2020-10-23T17:58:05.027Z soundsync:eventloop last 5 seconds: event loop blocked for 30.179327ms, mean: 11.640564662004662ms",
"2020-10-23T17:58:28.611Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'be1e3939-ac9d-43b6-96fa-915e2c3f34e2',\n instanceUuid: 'c26b1dd3-f3a6-4cad-88f6-2c31181b1d90',\n pipedFrom: 'ebef74cd-6b18-49e4-a256-9d0fdd23fdc7'\n }\n}",
"2020-10-23T17:58:28.615Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Linking audio source BlackHole 2ch (uuid ebef74cd-6b18-49e4-a256-9d0fdd23fdc7) to sink",
"2020-10-23T17:58:28.617Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Connecting to Airplay sink",
"2020-10-23T17:58:28.641Z soundsync:rtsp Connecting to 192.168.68.126:7000",
"2020-10-23T17:58:28.647Z soundsync:rtsp Connected",
"2020-10-23T17:58:28.648Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nApple-Challenge: ESTPXFSpex1Q+oKxJwc7Rw==",
"2020-10-23T17:58:28.656Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T17:58:29.094Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nContent-Type: application/sdp\r\nContent-Length: 186\r\n\r\nv=0\r\no=iTunes 1525032171 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.126\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T17:58:29.104Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5137;timing_port=6989",
"2020-10-23T17:58:29.158Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nSession: 1\r\nRTP-Info: seq=41221;rtptime=14509891",
"2020-10-23T17:58:29.170Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T17:58:29.178Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0",
"2020-10-23T17:58:30.030Z soundsync:eventloop last 5 seconds: event loop blocked for 27.901951ms, mean: 11.613426902325582ms",
"2020-10-23T17:58:35.916Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: 'c6c6d555-0754-48f5-a637-695cee6aec9e'\n }\n}",
"2020-10-23T17:58:45.184Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: null\n }\n}",
"2020-10-23T17:58:55.673Z soundsync:audioSinkDebug Stream started again",
"2020-10-23T17:59:05.036Z soundsync:eventloop last 5 seconds: event loop blocked for 38.076415ms, mean: 11.354139927272728ms",
"2020-10-23T17:59:08.827Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: null\n }\n}",
"2020-10-23T17:59:08.828Z soundsync:rtsp Sending TEARDOWN rtsp://192.168.68.108/2844575990 RTSP/1.0\r\nCSeq: 8\r\nUser-Agent: Soundsync\r\nDACP-ID: 2844575990\r\nClient-Instance: 2844575990\r\nSession: 1",
"2020-10-23T17:59:08.829Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Source stream has closed, unlinking",
"2020-10-23T17:59:10.331Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'be1e3939-ac9d-43b6-96fa-915e2c3f34e2',\n instanceUuid: 'c26b1dd3-f3a6-4cad-88f6-2c31181b1d90',\n pipedFrom: null\n }\n}",
"2020-10-23T17:59:10.332Z soundsync:rtsp Sending TEARDOWN rtsp://192.168.68.108/1525032171 RTSP/1.0\r\nCSeq: 8\r\nUser-Agent: Soundsync\r\nDACP-ID: 1525032171\r\nClient-Instance: 1525032171\r\nSession: 1",
"2020-10-23T17:59:10.332Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Source stream has closed, unlinking",
"2020-10-23T17:59:12.622Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '81360cc9-263e-44a2-b6ac-2fce296256ca',\n pipedFrom: 'c6c6d555-0754-48f5-a637-695cee6aec9e'\n }\n}",
"2020-10-23T17:59:12.622Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Linking audio source Spotify on Soundsync (uuid c6c6d555-0754-48f5-a637-695cee6aec9e) to sink",
"2020-10-23T17:59:12.624Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Connecting to Airplay sink",
"2020-10-23T17:59:12.643Z soundsync:rtsp Connecting to 192.168.68.121:7000",
"2020-10-23T17:59:12.652Z soundsync:rtsp Connected",
"2020-10-23T17:59:12.652Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nApple-Challenge: /tlxAauyVEk31s0Ng/2UyQ==",
"2020-10-23T17:59:12.658Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T17:59:13.092Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/366429079 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nContent-Type: application/sdp\r\nContent-Length: 185\r\n\r\nv=0\r\no=iTunes 366429079 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.121\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T17:59:13.099Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/366429079 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5529;timing_port=6287",
"2020-10-23T17:59:13.132Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/366429079 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nSession: 1\r\nRTP-Info: seq=28620;rtptime=10074430",
"2020-10-23T17:59:13.137Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/366429079 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T17:59:13.144Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/366429079 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 366429079\r\nClient-Instance: 366429079\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0",
"2020-10-23T17:59:15.036Z soundsync:eventloop last 5 seconds: event loop blocked for 24.936447ms, mean: 11.522852064665127ms",
"2020-10-23T17:59:18.095Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: 'c6c6d555-0754-48f5-a637-695cee6aec9e'\n }\n}",
"2020-10-23T17:59:18.096Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Linking audio source Spotify on Soundsync (uuid c6c6d555-0754-48f5-a637-695cee6aec9e) to sink",
"2020-10-23T17:59:18.097Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Starting localdevice sink",
"2020-10-23T17:59:18.118Z soundsync:synchronizedAudioBuffer = hard sync: 1782.5416666666667ms",
"2020-10-23T17:59:23.107Z soundsync:synchronizedAudioBuffer = soft sync: -69.625ms (-3342 samples), injecting -9 samples now",
"2020-10-23T17:59:26.989Z soundsync:synchronizedAudioBuffer = finished delayed soft drift correction",
"2020-10-23T17:59:37.797Z soundsync:peer:6d4a173b-7815-4a95-aeae-a697faffd9ec:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: '8ddc0495-94cd-4701-9a46-6dc4b1670aec',\n instanceUuid: '490143da-8912-43ab-a7d3-82af6c9b2b29',\n pipedFrom: null\n }\n}",
"2020-10-23T17:59:37.798Z soundsync:audioSink:8ddc0495-94cd-4701-9a46-6dc4b1670aec Source stream has closed, unlinking",
"2020-10-23T17:59:40.041Z soundsync:eventloop last 5 seconds: event loop blocked for 200.540159ms, mean: 11.95382323444976ms"
]
}
And here's another one from trying to pipe my microphone to two different sonos speakers via airplay where it looks fine, but never heard anything
"2020-10-23T18:22:41.265Z soundsync:sourcesSinksManager Detecting local audio devices",
"2020-10-23T18:22:41.267Z soundsync:httpserver Creating new http server",
"2020-10-23T18:22:41.273Z soundsync:httpserver Listening on 6512",
"2020-10-23T18:22:41.273Z soundsync:httpserver Creating https server on 6513",
"2020-10-23T18:22:41.284Z soundsync:rendezvous Registering to rendezvous service with: 192.168.68.108:6512_deb6e192-1531-4711-a8cc-f5bf23003407",
"2020-10-23T18:22:41.286Z soundsync:loopbackDeviceManager Loopback interface creation not supported on audiounit-rust",
"2020-10-23T18:22:41.286Z soundsync:clientCoordinator Created client coordinator",
"2020-10-23T18:22:41.293Z soundsync:mdns Bound to address 192.168.68.108 and port 0",
"2020-10-23T18:22:41.294Z soundsync:mdns Bound to address 0.0.0.0 and port 5353",
"2020-10-23T18:22:41.390Z soundsync:updater Updater starting, current version: 0.4.7",
"2020-10-23T18:22:41.390Z soundsync:updater Checking for update",
"2020-10-23T18:22:41.486Z soundsync:audioSource:c6c6d555-0754-48f5-a637-695cee6aec9e Starting librespot process",
"2020-10-23T18:22:41.920Z soundsync:peer:placeholderForHttpApiJoin_192.168.68.108:6512 Created new peer",
"2020-10-23T18:22:41.959Z soundsync:peer:placeholderForHttpApiJoin_192.168.68.108:6512 Cannot connect to peer with initiator http api http initiator error: 409: Connecting to own peer",
"2020-10-23T18:22:42.218Z soundsync:peer:placeholderForHttpApiJoin_fe80::aede:48ff:fe00:1122:6512 Created new peer",
"2020-10-23T18:22:42.229Z soundsync:peer:placeholderForHttpApiJoin_fe80::aede:48ff:fe00:1122:6512 Cannot connect to peer with initiator http api getaddrinfo ENOTFOUND fe80",
"2020-10-23T18:22:42.514Z soundsync:updater Update for version 0.4.7 is not available (latest version: 0.4.7, downgrade is disallowed).",
"2020-10-23T18:22:46.214Z soundsync:eventloop last 5 seconds: event loop blocked for 141.819903ms, mean: 11.834907207729469ms",
"2020-10-23T18:22:50.702Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe Created new peer",
"2020-10-23T18:22:50.703Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe Setting remote description",
"2020-10-23T18:22:50.704Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe Creating answer",
"2020-10-23T18:22:50.705Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe Setting local description",
"2020-10-23T18:22:50.706Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe Sending answer",
"2020-10-23T18:22:50.723Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe:peerInfo Sending controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n name: 'RacemicCeramic.local',\n instanceUuid: '76b4db96-6c95-422e-bbfa-8d94d6e45078',\n capacities: [\n 'librespot',\n 'shairport',\n 'http_server_accessible',\n 'hue',\n 'chromecast_interaction',\n 'shared_state_keeper',\n 'airplay_sink'\n ],\n version: '0.4.7'\n },\n sharedState: { hueBridges: [], lastUpdateTimestamp: -1 }\n}",
"2020-10-23T18:22:50.730Z soundsync:peer:placeholderForHttpInitiatorRequest_b2d3a805-f66d-4e92-8fd8-731845ba4cbe:peerInfo Received controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'd0390657-1fd4-4e38-a764-0389d841549a',\n name: 'Web page',\n instanceUuid: 'f1903430-550c-4c71-b48f-43f3c0612bdb',\n capacities: [],\n version: '0.4.7'\n }\n}",
"2020-10-23T18:22:50.731Z soundsync:peer:d0390657-1fd4-4e38-a764-0389d841549a Connected",
"2020-10-23T18:22:50.733Z soundsync:sourcesSinksManager Adding sink Web Page Output of type webaudio",
"2020-10-23T18:22:50.734Z soundsync:audioSink:4b8c8243-27b8-4bbe-85ed-3d6243baaeb4 Created new audio sink of type webaudio",
"2020-10-23T18:22:51.035Z soundsync:peer:d0390657-1fd4-4e38-a764-0389d841549a Updating timedelta to -9443.752764000092, diff: -9443.75ms",
"2020-10-23T18:22:51.213Z soundsync:eventloop last 5 seconds: event loop blocked for 363.331583ms, mean: 12.390847205955335ms",
"2020-10-23T18:22:51.651Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Created new peer",
"2020-10-23T18:22:51.651Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Received candidate but connection was not yet initialized, ignoring",
"2020-10-23T18:22:51.653Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Setting remote description",
"2020-10-23T18:22:51.655Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Creating answer",
"2020-10-23T18:22:51.655Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Setting local description",
"2020-10-23T18:22:51.656Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Sending answer",
"2020-10-23T18:22:51.774Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:51.775Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:52.781Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:52.782Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:54.115Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571:peerInfo Sending controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'deb6e192-1531-4711-a8cc-f5bf23003407',\n name: 'RacemicCeramic.local',\n instanceUuid: '76b4db96-6c95-422e-bbfa-8d94d6e45078',\n capacities: [\n 'librespot',\n 'shairport',\n 'http_server_accessible',\n 'hue',\n 'chromecast_interaction',\n 'shared_state_keeper',\n 'airplay_sink'\n ],\n version: '0.4.7'\n },\n sharedState: { hueBridges: [], lastUpdateTimestamp: -1 }\n}",
"2020-10-23T18:22:54.119Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571:peerInfo Received controller message {\n type: 'peerInfo',\n peer: {\n uuid: 'd0390657-1fd4-4e38-a764-0389d841549a',\n name: 'Web page',\n instanceUuid: 'f1903430-550c-4c71-b48f-43f3c0612bdb',\n capacities: [],\n version: '0.4.7'\n }\n}",
"2020-10-23T18:22:54.119Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Destroying peer, reason: Peer is already connected, this is a duplicate",
"2020-10-23T18:22:54.120Z soundsync:peer:placeholderForRendezvousInitiatorRequest_3e6c86df-a1dc-4db3-b29d-d0ab2141e571 Cleaning webrtc state",
"2020-10-23T18:22:55.792Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:55.792Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:56.866Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:56.866Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:57.872Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:57.873Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:22:58.879Z soundsync:peer:d0390657-1fd4-4e38-a764-0389d841549a:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'a3e52434-e11e-4520-aad1-cdde44952732',\n instanceUuid: '7a3eaa11-1a67-46ad-b5b9-a6f80dbed3b8',\n pipedFrom: '3448a68c-907e-4b10-9370-8358ec0689e2'\n }\n}",
"2020-10-23T18:22:58.881Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407:rpc Received controller message {\n type: 'rpc',\n rpcType: 'startSource',\n isResponse: false,\n body: '3448a68c-907e-4b10-9370-8358ec0689e2',\n uuid: '6e3e7283-d31f-4ea9-86eb-46054e803f34'\n}",
"2020-10-23T18:22:58.881Z soundsync:audioSource:3448a68c-907e-4b10-9370-8358ec0689e2 Starting audio source",
"2020-10-23T18:22:58.885Z soundsync:audioSource:3448a68c-907e-4b10-9370-8358ec0689e2 Creating localdevice source",
"2020-10-23T18:22:58.922Z soundsync:peer:deb6e192-1531-4711-a8cc-f5bf23003407:rpc Received controller message {\n type: 'rpc',\n isResponse: true,\n body: undefined,\n uuid: '6e3e7283-d31f-4ea9-86eb-46054e803f34',\n rpcType: 'startSource'\n}",
"2020-10-23T18:22:59.209Z soundsync:audioSinkDebug Stream started again",
"2020-10-23T18:22:59.223Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Linking audio source MacBook Pro Microphone (uuid 3448a68c-907e-4b10-9370-8358ec0689e2) to sink",
"2020-10-23T18:22:59.227Z soundsync:audioSink:a3e52434-e11e-4520-aad1-cdde44952732 Connecting to Airplay sink",
"2020-10-23T18:22:59.250Z soundsync:rtsp Connecting to 192.168.68.121:7000",
"2020-10-23T18:22:59.290Z soundsync:rtsp Connected",
"2020-10-23T18:22:59.291Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nApple-Challenge: 41g0VQMFGMijcB5YTx8eOg==",
"2020-10-23T18:22:59.298Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T18:22:59.835Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/3020260536 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nContent-Type: application/sdp\r\nContent-Length: 186\r\n\r\nv=0\r\no=iTunes 3020260536 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.121\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T18:22:59.842Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/3020260536 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5466;timing_port=6265",
"2020-10-23T18:22:59.874Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/3020260536 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nSession: 1\r\nRTP-Info: seq=1151;rtptime=405376",
"2020-10-23T18:22:59.886Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/3020260536 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T18:22:59.893Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/3020260536 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 3020260536\r\nClient-Instance: 3020260536\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0",
"2020-10-23T18:23:00.881Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:23:00.881Z soundsync:mdns Received mdns request for 3e6c86dfa1dc4db3b29dd0ab2141e571eb6e19215314711a8ccf5bf23003407.local, handling initiator notification",
"2020-10-23T18:23:01.214Z soundsync:eventloop last 5 seconds: event loop blocked for 48.758783ms, mean: 11.35518498405467ms",
"2020-10-23T18:23:05.680Z soundsync:peer:d0390657-1fd4-4e38-a764-0389d841549a:sinkPatch Received controller message {\n type: 'sinkPatch',\n sink: {\n uuid: 'be1e3939-ac9d-43b6-96fa-915e2c3f34e2',\n instanceUuid: '9f6788e9-0e88-4d98-b656-7041943e6c20',\n pipedFrom: '3448a68c-907e-4b10-9370-8358ec0689e2'\n }\n}",
"2020-10-23T18:23:05.681Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Linking audio source MacBook Pro Microphone (uuid 3448a68c-907e-4b10-9370-8358ec0689e2) to sink",
"2020-10-23T18:23:05.682Z soundsync:audioSink:be1e3939-ac9d-43b6-96fa-915e2c3f34e2 Connecting to Airplay sink",
"2020-10-23T18:23:05.697Z soundsync:rtsp Connecting to 192.168.68.126:7000",
"2020-10-23T18:23:05.709Z soundsync:rtsp Connected",
"2020-10-23T18:23:05.709Z soundsync:rtsp Sending OPTIONS * RTSP/1.0\r\nCSeq: 1\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nApple-Challenge: nZbI4kKqTh2bbR0TcctHUQ==",
"2020-10-23T18:23:05.719Z soundsync:rtsp Sending POST /auth-setup RTSP/1.0\r\nCSeq: 2\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nContent-Type: application/octet-stream\r\nContent-Length: 33\r\n\r\n\u0001Y\u0002��\rN�L��c0\u0003�\u0007�M�PتF[]�\u0001*\f~\u001dN",
"2020-10-23T18:23:06.161Z soundsync:rtsp Sending ANNOUNCE rtsp://192.168.68.108/3115059482 RTSP/1.0\r\nCSeq: 3\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nContent-Type: application/sdp\r\nContent-Length: 186\r\n\r\nv=0\r\no=iTunes 3115059482 O IN IP4 192.168.68.108\r\ns=iTunes\r\nc=IN IP4 192.168.68.126\r\nt=0 0\r\nm=audio 0 RTP/AVP 96\r\na=rtpmap:96 AppleLossless\r\na=fmtp:96 352 0 16 40 10 14 2 255 0 0 44100",
"2020-10-23T18:23:06.168Z soundsync:rtsp Sending SETUP rtsp://192.168.68.108/3115059482 RTSP/1.0\r\nCSeq: 4\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nTransport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=5505;timing_port=6117",
"2020-10-23T18:23:06.212Z soundsync:rtsp Sending RECORD rtsp://192.168.68.108/3115059482 RTSP/1.0\r\nCSeq: 5\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nSession: 1\r\nRTP-Info: seq=1945;rtptime=684877",
"2020-10-23T18:23:06.215Z soundsync:eventloop last 5 seconds: event loop blocked for 24.215551ms, mean: 11.508542525345621ms",
"2020-10-23T18:23:06.223Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/3115059482 RTSP/1.0\r\nCSeq: 6\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 13\r\n\r\nvolume: -33",
"2020-10-23T18:23:06.237Z soundsync:rtsp Sending SET_PARAMETER rtsp://192.168.68.108/3115059482 RTSP/1.0\r\nCSeq: 7\r\nUser-Agent: Soundsync\r\nDACP-ID: 3115059482\r\nClient-Instance: 3115059482\r\nSession: 1\r\nContent-Type: text/parameters\r\nContent-Length: 11\r\n\r\nvolume: 0"
]
}