{"action":"created","issue":{"url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/279","repository_url":"https://api.github.com/repos/mikebrady/shairport-sync","labels_url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/279/labels{/name}","comments_url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/279/comments","events_url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/279/events","html_url":"https://github.com/mikebrady/shairport-sync/issues/279","id":151094843,"number":279,"title":"can't play from allstream on android: 'packets out of sequence', 'Error -32 in delay(): \"Broken pipe\"'","user":{"login":"jordanade","id":2799445,"avatar_url":"https://avatars.githubusercontent.com/u/2799445?v=3","gravatar_id":"","url":"https://api.github.com/users/jordanade","html_url":"https://github.com/jordanade","followers_url":"https://api.github.com/users/jordanade/followers","following_url":"https://api.github.com/users/jordanade/following{/other_user}","gists_url":"https://api.github.com/users/jordanade/gists{/gist_id}","starred_url":"https://api.github.com/users/jordanade/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/jordanade/subscriptions","organizations_url":"https://api.github.com/users/jordanade/orgs","repos_url":"https://api.github.com/users/jordanade/repos","events_url":"https://api.github.com/users/jordanade/events{/privacy}","received_events_url":"https://api.github.com/users/jordanade/received_events","type":"User","site_admin":false},"labels":[],"state":"open","locked":false,"assignee":null,"milestone":null,"comments":21,"created_at":"2016-04-26T10:11:05Z","updated_at":"2016-05-02T21:47:12Z","closed_at":null,"body":"When I try to connect and play from allstream, I get no audio--except every several seconds, there's a tiny chirp of the audio that comes through. Here's a -vvv output:\r\n\r\n===== here I run shairport-sync -a test -vvv ======\r\n\r\nLooking for the configuration file \"/etc/shairport-sync.conf\".\r\nLooking for configuration file at full path \"/etc/shairport-sync.conf\"\r\nOutput device name is \"hw:1,0\".\r\nThe processor is running little-endian.\r\nVersion: \"2.8.3-openssl-Avahi-ALSA-soxr-metadata\"\r\nstatistics_requester status is 0.\r\ndaemon status is 0.\r\nrtsp listening port is 5000.\r\nudp base port is 6001.\r\nudp port range is 100.\r\nShairport Sync player name is \"test\".\r\nAudio Output name is \"(null)\".\r\non-start action is \"(null)\".\r\non-stop action is \"(null)\".\r\nwait-cmd status is 0.\r\nmdns backend \"(null)\".\r\nuserSuppliedLatency is 0.\r\nAirPlayLatency is -1.\r\niTunesLatency is -1.\r\nforkedDaapdLatency is -1.\r\nstuffing option is \"1\".\r\nresync time is 2205.\r\nallow a session to be interrupted: 0.\r\nbusy timeout time is 120.\r\ndrift tolerance is 88 frames.\r\npassword is \"(null)\".\r\nignore_volume_control is 0.\r\ndisable_synchronization is 0.\r\naudio backend desired buffer length is 6615.\r\naudio backend latency offset is 0.\r\nvolume range in dB (zero means use the range specified by the mixer): 0.\r\nzeroconf regtype is \"_raop._tcp\".\r\nconfiguration file name \"/etc/shairport-sync.conf\" resolves to \"/etc/shairport-sync.conf\".\r\nmetdata enabled is 0.\r\nmetadata pipename is \"(null)\".\r\nget-coverart is 0.\r\navahi: avahi_register.\r\navahi: register_service.\r\navahi: service '098F6BCD4621@test' group is not yet commited.\r\navahi: request to add \"_raop._tcp\" service without metadata\r\navahi: service '098F6BCD4621@test' group is registering.\r\navahi: service '098F6BCD4621@test' successfully added.\r\navahi: address advertised is: \"fe80::c654:44ff:fe3a:e75\".\r\navahi: address advertised is: \"10.0.0.2\".\r\n\r\n===== Here I connect allstream =====\r\n\r\nNew RTSP connection on port 5000\r\n    Client-Instance: B370A9CB22EED3A7.\r\n    DACP-ID: B370A9CB22EED3A7.\r\n    CSeq: 0.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Apple-Challenge: BkHbHsq6O3lrVFHzTTxWag==.\r\n    Client-Instance: B370A9CB22EED3A7.\r\n    DACP-ID: B370A9CB22EED3A7.\r\n    CSeq: 1.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Content-Type: application/sdp.\r\n    Content-Length: 570.\r\nPlay connection from user agent \"iTunes/7.6.2 (Windows; N;)\".\r\n    Client-Instance: B370A9CB22EED3A7.\r\n    DACP-ID: B370A9CB22EED3A7.\r\n    CSeq: 2.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Transport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=35083;timing_port=37051.\r\nDACP-ID string seen: \"B370A9CB22EED3A7\".\r\nrtp_setup: cport=35083 tport=37051.\r\nConnection from IPv4: 10.0.0.20:38631\r\nlistening for audio, control and timing on ports 6001, 6002, 6003.\r\nTiming receiver -- Server RTP thread starting.\r\nAudio receiver -- Server RTP thread starting.\r\nControl receiver -- Server RTP thread starting.\r\nTiming sender thread starting.\r\n    Client-Instance: B370A9CB22EED3A7.\r\n    DACP-ID: B370A9CB22EED3A7.\r\n    CSeq: 3.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Session: 1.\r\n    RTP-Info: seq=51128;rtptime=1102327727.\r\n    Range: npt=0-.\r\nFlush requested up to 1102327726. It seems as if 0 is special.\r\n    Client-Instance: B370A9CB22EED3A7.\r\n    DACP-ID: B370A9CB22EED3A7.\r\n    CSeq: 4.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Session: 1.\r\n    Content-Type: text/parameters.\r\n    Content-Length: 13.\r\nSET_PARAMETER Content-Type:\"text/parameters\".\r\nreceived parameters in SET_PARAMETER request.\r\nvolume: 0.000000\r\n\r\nsyncing to seqno 51129.\r\nPCM handle name = 'hw:1,0'\r\nalsa device parameters:\r\n  access type = RW_INTERLEAVED\r\n  format = 'S16_LE' (Signed 16 bit Little Endian)\r\n  subformat = 'STD' (Standard)\r\n  number of channels = 2\r\n  number of significant bits = 16\r\n  rate = 44100 frames per second (precisely).\r\n  precise (rational) rate = 44100.000 frames per second (i.e. 44100/1).\r\n  period_time = 11609 us (>).\r\n  period_size = 512 frames (precisely).\r\n  buffer_time = 371519 us (>).\r\n  buffer_size = 16384 frames (>).\r\n  periods_per_buffer = 32 (precisely).\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\n\r\n===== Here I start playing audio =====\r\n\r\nAliasing of buffer index -- reset.\r\nPlayer: packets out of sequence: expected: 51136, got: 52672, with ab_read: 52673 and ab_write: 53174.\r\nLost sync with source for 4 consecutive packets -- flushing and resyncing. Error: -6142.\r\nFlush requested up to 1102872271. It seems as if 0 is special.\r\nsyncing to seqno 53174.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7969.4,    26579.3,   162093.0.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7970.5,    26672.1,   152755.0.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nAliasing of buffer index -- reset.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7966.8,    26777.7,   200336.0.\r\nPlayer: packets out of sequence: expected: 57786, got: 58298, with ab_read: 58299 and ab_write: 58805.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nLost sync with source for 4 consecutive packets -- flushing and resyncing. Error: -6218.\r\nFlush requested up to 1104852623. It seems as if 0 is special.\r\nsyncing to seqno 58805.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8006.7,    26928.4,   254060.0.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nAliasing of buffer index -- reset.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nError -32 in delay(): \"Broken pipe\". Delay reported is 0 frames.\r\nDelay error -32 when checking running latency.\r\nAliasing of buffer index -- reset.\r\nPlayer: packets out of sequence: expected: 62394, got: 62906, with ab_read: 62907 and ab_write: 63409.\r\nLost sync with source for 4 consecutive packets -- flushing and resyncing. Error: -6533.\r\nFlush requested up to 1106473583. It seems as if 0 is special.\r\nsyncing to seqno 63409.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7965.7,    26523.7,   164601.0.\r\n\r\n===== end of log ======\r\n\r\nI also emailed allstream about this, their address is allstream@kineticgamestudios.com\r\n\r\nThanks,\r\nJordanade"},"comment":{"url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/comments/216374182","html_url":"https://github.com/mikebrady/shairport-sync/issues/279#issuecomment-216374182","issue_url":"https://api.github.com/repos/mikebrady/shairport-sync/issues/279","id":216374182,"user":{"login":"jordanade","id":2799445,"avatar_url":"https://avatars.githubusercontent.com/u/2799445?v=3","gravatar_id":"","url":"https://api.github.com/users/jordanade","html_url":"https://github.com/jordanade","followers_url":"https://api.github.com/users/jordanade/followers","following_url":"https://api.github.com/users/jordanade/following{/other_user}","gists_url":"https://api.github.com/users/jordanade/gists{/gist_id}","starred_url":"https://api.github.com/users/jordanade/starred{/owner}{/repo}","subscriptions_url":"https://api.github.com/users/jordanade/subscriptions","organizations_url":"https://api.github.com/users/jordanade/orgs","repos_url":"https://api.github.com/users/jordanade/repos","events_url":"https://api.github.com/users/jordanade/events{/privacy}","received_events_url":"https://api.github.com/users/jordanade/received_events","type":"User","site_admin":false},"created_at":"2016-05-02T21:47:12Z","updated_at":"2016-05-02T21:47:12Z","body":"I don't hear any gaps anymore, although the sync with my airport express now seems to be loose enough to create an obvious reverberation effect in my apartment.\r\n\r\n$ shairport-sync -a test -vvv\r\nLooking for the configuration file \"/etc/shairport-sync.conf\".\r\nLooking for configuration file at full path \"/etc/shairport-sync.conf\"\r\nOutput device name is \"hw:1,0\".\r\nThe processor is running little-endian.\r\nVersion: \"2.8.3.1-openssl-Avahi-ALSA-soxr-metadata\"\r\nstatistics_requester status is 1.\r\ndaemon status is 0.\r\nrtsp listening port is 5000.\r\nudp base port is 6001.\r\nudp port range is 100.\r\nShairport Sync player name is \"test\".\r\nAudio Output name is \"(null)\".\r\non-start action is \"(null)\".\r\non-stop action is \"(null)\".\r\nwait-cmd status is 0.\r\nmdns backend \"(null)\".\r\nuserSuppliedLatency is 0.\r\nAirPlayLatency is -1.\r\niTunesLatency is -1.\r\nforkedDaapdLatency is -1.\r\nstuffing option is \"1\".\r\nresync time is 0.\r\nallow a session to be interrupted: 0.\r\nbusy timeout time is 120.\r\ndrift tolerance is 5000 frames.\r\npassword is \"(null)\".\r\nignore_volume_control is 0.\r\nmono is 0.\r\ndisable_synchronization is 0.\r\naudio backend desired buffer length is 11025.\r\naudio backend latency offset is 0.\r\nvolume range in dB (zero means use the range specified by the mixer): 0.\r\nzeroconf regtype is \"_raop._tcp\".\r\nconfiguration file name \"/etc/shairport-sync.conf\" resolves to \"/etc/shairport-sync.conf\".\r\nmetdata enabled is 0.\r\nmetadata pipename is \"(null)\".\r\nmetadata socket address is \"(null)\" port 0.\r\nmetadata socket packet size is \"500\".\r\nget-coverart is 0.\r\navahi: avahi_register.\r\navahi: register_service.\r\navahi: service '098F6BCD4621@test' group is not yet commited.\r\navahi: request to add \"_raop._tcp\" service without metadata\r\navahi: service '098F6BCD4621@test' group is registering.\r\navahi: service '098F6BCD4621@test' successfully added.\r\navahi: address advertised is: \"fe80::c654:44ff:fe3a:e75\".\r\navahi: address advertised is: \"10.0.0.2\".\r\nNew RTSP connection on port 5000\r\n    Client-Instance: F126A5BC6B075321.\r\n    DACP-ID: F126A5BC6B075321.\r\n    CSeq: 0.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Apple-Challenge: BkHbHsq6O3lrVFHzTTxWag==.\r\n    Client-Instance: F126A5BC6B075321.\r\n    DACP-ID: F126A5BC6B075321.\r\n    CSeq: 1.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Content-Type: application/sdp.\r\n    Content-Length: 570.\r\nPlay connection from user agent \"iTunes/7.6.2 (Windows; N;)\".\r\n    Client-Instance: F126A5BC6B075321.\r\n    DACP-ID: F126A5BC6B075321.\r\n    CSeq: 2.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Transport: RTP/AVP/UDP;unicast;interleaved=0-1;mode=record;control_port=43996;timing_port=32985.\r\nDACP-ID string seen: \"F126A5BC6B075321\".\r\nrtp_setup: cport=43996 tport=32985.\r\nConnection from IPv4: 10.0.0.20:60643\r\nlistening for audio, control and timing on ports 6001, 6002, 6003.\r\nTiming receiver -- Server RTP thread starting.\r\nControl receiver -- Server RTP thread starting.\r\nAudio receiver -- Server RTP thread starting.\r\nTiming sender thread starting.\r\n    Client-Instance: F126A5BC6B075321.\r\n    DACP-ID: F126A5BC6B075321.\r\n    CSeq: 3.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Session: 1.\r\n    RTP-Info: seq=7991;rtptime=1053535765.\r\n    Range: npt=0-.\r\nFlush requested up to 1053535764. It seems as if 0 is special.\r\n    Client-Instance: F126A5BC6B075321.\r\n    DACP-ID: F126A5BC6B075321.\r\n    CSeq: 4.\r\n    User-Agent: iTunes/7.6.2 (Windows; N;).\r\n    Session: 1.\r\n    Content-Type: text/parameters.\r\n    Content-Length: 15.\r\nSET_PARAMETER Content-Type:\"text/parameters\".\r\nreceived parameters in SET_PARAMETER request.\r\nvolume: -3.300000\r\n\r\nUsing negotiated latency of 99225 frames.\r\nsyncing to seqno 7992.\r\nPCM handle name = 'hw:1,0'\r\nalsa device parameters:\r\n  access type = RW_INTERLEAVED\r\n  format = 'S16_LE' (Signed 16 bit Little Endian)\r\n  subformat = 'STD' (Standard)\r\n  number of channels = 2\r\n  number of significant bits = 16\r\n  rate = 44100 frames per second (precisely).\r\n  precise (rational) rate = 44100.000 frames per second (i.e. 44100/1).\r\n  period_time = 11609 us (>).\r\n  period_size = 512 frames (precisely).\r\n  buffer_time = 371519 us (>).\r\n  buffer_size = 16384 frames (>).\r\n  periods_per_buffer = 32 (precisely).\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7967.2,    26389.6,   175264.0.\r\nSync error: 2091.7 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 3758; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 4408, min and max buffer occupancy 234 and 276.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7974.1,    26505.4,   199030.0.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7957.6,    26790.8,   138208.0.\r\nSync error: 2259.4 (frames); net correction: -44.6 (ppm); corrections: 44.6 (ppm); total packets 7516; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 10581, min and max buffer occupancy 235 and 264.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8017.2,    25801.5,   146857.0.\r\nSync error: 1935.7 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 11274; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 10131, min and max buffer occupancy 231 and 264.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7972.4,    25522.9,   178637.0.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8004.0,    25443.1,   136685.0.\r\nSync error: 1675.9 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 15032; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9886, min and max buffer occupancy 237 and 264.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7955.9,    25364.0,   134604.0.\r\nSync error: 1845.1 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 18790; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 8955, min and max buffer occupancy 236 and 266.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8016.2,    25711.0,   139392.0.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7961.6,    25707.0,   143479.0.\r\nSync error: 1804.1 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 22548; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9698, min and max buffer occupancy 235 and 265.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8008.0,    25576.8,   152379.0.\r\nSync error: 1590.3 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 26306; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9539, min and max buffer occupancy 236 and 265.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7959.2,    25588.5,   138091.0.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7970.9,    25376.1,   138451.0.\r\nSync error: 1701.4 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 30064; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9526, min and max buffer occupancy 234 and 266.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7962.7,    25476.1,   150576.0.\r\nSync error: 1604.3 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 33822; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9645, min and max buffer occupancy 236 and 265.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7963.1,    25673.6,   168165.0.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8011.2,    25738.8,   145943.0.\r\nSync error: 1706.4 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 37580; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9868, min and max buffer occupancy 234 and 264.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     7963.4,    25549.9,   144595.0.\r\nSync error: 1713.7 (frames); net correction: 0.0 (ppm); corrections: 0.0 (ppm); total packets 41338; missing packets 0; late packets 0; too late packets 0; resend requests 0; min DAC queue size 9623, min and max buffer occupancy 235 and 265.\r\nPacket reception interval stats: mean, standard deviation and max for the last 2,500 packets in microseconds:     8005.6,    25622.2,   150675.0.\r\n...."}}