when MAX_DELAY=1:
2021-12-10 12:13:56.105795-0800 avsbartest[5784:9241256] starting synchronizer
2021-12-10 12:13:56.161441-0800 avsbartest[5784:9241256] synchronizer rate is 1.000000
2021-12-10 12:13:56.162566-0800 avsbartest[5784:9241256] enqueued=0.400000 time=0.000000 base=0.000000
2021-12-10 12:13:56.164215-0800 avsbartest[5784:9241256] enqueued=0.600000 time=0.000000 base=0.000000
2021-12-10 12:13:56.165504-0800 avsbartest[5784:9241256] enqueued=0.800000 time=0.000000 base=0.000000
2021-12-10 12:13:56.167032-0800 avsbartest[5784:9241256] enqueued=1.000000 time=0.000000 base=0.000000
2021-12-10 12:13:56.168931-0800 avsbartest[5784:9241256] enqueued=1.200000 time=0.000000 base=0.000000
2021-12-10 12:13:57.824510-0800 avsbartest[5784:9241053] synchronizer time = 0.000000 (enqueued = 1.200000)
2021-12-10 12:13:57.826529-0800 avsbartest[5784:9241053] synchronizer time = 0.000000 (enqueued = 1.200000)
2021-12-10 12:13:58.318621-0800 avsbartest[5784:9241053] synchronizer past zero! [0.001239]
2021-12-10 12:13:58.517927-0800 avsbartest[5784:9241053] synchronizer time = 0.200547 (enqueued = 1.200000)
notice 2s+ delay between setRate:1.0 call (@ 56.161) and currentTime increase (@ 58.318)
when MAX_DELAY=2:
2021-12-10 12:24:53.640527-0800 avsbartest[5855:9244456] synchronizer rate is 1.000000
2021-12-10 12:24:53.640762-0800 avsbartest[5855:9244456] enqueued=0.400000 time=0.000000 base=0.000000
2021-12-10 12:24:53.641085-0800 avsbartest[5855:9244456] enqueued=0.600000 time=0.000000 base=0.000000
2021-12-10 12:24:53.641406-0800 avsbartest[5855:9244456] enqueued=0.800000 time=0.000000 base=0.000000
2021-12-10 12:24:53.641707-0800 avsbartest[5855:9244456] enqueued=1.000000 time=0.000000 base=0.000000
2021-12-10 12:24:53.641981-0800 avsbartest[5855:9244456] enqueued=1.200000 time=0.000000 base=0.000000
2021-12-10 12:24:53.642296-0800 avsbartest[5855:9244456] enqueued=1.400000 time=0.000000 base=0.000000
2021-12-10 12:24:53.642559-0800 avsbartest[5855:9244456] enqueued=1.600000 time=0.000000 base=0.000000
2021-12-10 12:24:53.642837-0800 avsbartest[5855:9244456] enqueued=1.800000 time=0.000000 base=0.000000
2021-12-10 12:24:53.643108-0800 avsbartest[5855:9244456] enqueued=2.000000 time=0.000000 base=0.000000
2021-12-10 12:24:53.643398-0800 avsbartest[5855:9244456] enqueued=2.200000 time=0.000000 base=0.000000
2021-12-10 12:24:55.306210-0800 avsbartest[5855:9244295] synchronizer time = 0.000000 (enqueued = 2.200000)
2021-12-10 12:24:55.307570-0800 avsbartest[5855:9244295] synchronizer time = 0.000000 (enqueued = 2.200000)
2021-12-10 12:24:55.802047-0800 avsbartest[5855:9244295] synchronizer past zero! [0.001384]
2021-12-10 12:24:56.001163-0800 avsbartest[5855:9244295] synchronizer time = 0.200505 (enqueued = 2.200000)
still a huge delay 53.640 -> 55.802
when MAX_DELAY=6:
2021-12-10 12:26:50.609567-0800 avsbartest[5869:9245549] starting synchronizer
2021-12-10 12:26:50.640061-0800 avsbartest[5869:9245549] synchronizer rate is 1.000000
2021-12-10 12:26:50.640366-0800 avsbartest[5869:9245549] enqueued=0.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.640685-0800 avsbartest[5869:9245549] enqueued=0.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.640962-0800 avsbartest[5869:9245549] enqueued=0.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.641230-0800 avsbartest[5869:9245549] enqueued=1.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.641511-0800 avsbartest[5869:9245549] enqueued=1.200000 time=0.000000 base=0.000000
2021-12-10 12:26:50.641754-0800 avsbartest[5869:9245549] enqueued=1.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.641989-0800 avsbartest[5869:9245549] enqueued=1.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.642259-0800 avsbartest[5869:9245549] enqueued=1.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.642603-0800 avsbartest[5869:9245549] enqueued=2.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.642986-0800 avsbartest[5869:9245549] enqueued=2.200000 time=0.000000 base=0.000000
2021-12-10 12:26:50.643275-0800 avsbartest[5869:9245549] enqueued=2.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.643534-0800 avsbartest[5869:9245549] enqueued=2.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.643834-0800 avsbartest[5869:9245549] enqueued=2.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.644063-0800 avsbartest[5869:9245549] enqueued=3.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.644335-0800 avsbartest[5869:9245549] enqueued=3.200000 time=0.000000 base=0.000000
2021-12-10 12:26:50.644591-0800 avsbartest[5869:9245549] enqueued=3.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.644844-0800 avsbartest[5869:9245549] enqueued=3.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.645163-0800 avsbartest[5869:9245549] enqueued=3.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.645394-0800 avsbartest[5869:9245549] enqueued=4.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.645754-0800 avsbartest[5869:9245549] enqueued=4.200000 time=0.000000 base=0.000000
2021-12-10 12:26:50.646003-0800 avsbartest[5869:9245549] enqueued=4.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.646503-0800 avsbartest[5869:9245549] enqueued=4.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.647197-0800 avsbartest[5869:9245549] enqueued=4.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.647468-0800 avsbartest[5869:9245549] enqueued=5.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.648031-0800 avsbartest[5869:9245549] enqueued=5.200000 time=0.000000 base=0.000000
2021-12-10 12:26:50.648326-0800 avsbartest[5869:9245549] enqueued=5.400000 time=0.000000 base=0.000000
2021-12-10 12:26:50.648788-0800 avsbartest[5869:9245549] enqueued=5.600000 time=0.000000 base=0.000000
2021-12-10 12:26:50.649072-0800 avsbartest[5869:9245549] enqueued=5.800000 time=0.000000 base=0.000000
2021-12-10 12:26:50.649304-0800 avsbartest[5869:9245549] enqueued=6.000000 time=0.000000 base=0.000000
2021-12-10 12:26:50.649536-0800 avsbartest[5869:9245549] enqueued=6.200000 time=0.000000 base=0.000000
2021-12-10 12:26:52.154931-0800 avsbartest[5869:9245434] synchronizer time = 0.000000 (enqueued = 6.200000)
2021-12-10 12:26:52.155092-0800 avsbartest[5869:9245434] synchronizer time = 0.000000 (enqueued = 6.200000)
2021-12-10 12:26:52.655156-0800 avsbartest[5869:9245434] synchronizer past zero! [0.000917]
2021-12-10 12:26:52.855115-0800 avsbartest[5869:9245434] synchronizer time = 0.200876 (enqueued = 6.200000)
no change really, 50.640 -> 52.655
when MAX_DELAY=12:
2021-12-10 12:28:20.914048-0800 avsbartest[5880:9246482] starting synchronizer
2021-12-10 12:28:21.170354-0800 avsbartest[5880:9246482] synchronizer rate is 1.000000
2021-12-10 12:28:21.170647-0800 avsbartest[5880:9246482] enqueued=0.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.171083-0800 avsbartest[5880:9246482] enqueued=0.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.171509-0800 avsbartest[5880:9246482] enqueued=0.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.171885-0800 avsbartest[5880:9246482] enqueued=1.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.172241-0800 avsbartest[5880:9246482] enqueued=1.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.172576-0800 avsbartest[5880:9246482] enqueued=1.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.172980-0800 avsbartest[5880:9246482] enqueued=1.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.173318-0800 avsbartest[5880:9246482] enqueued=1.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.173752-0800 avsbartest[5880:9246482] enqueued=2.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.174197-0800 avsbartest[5880:9246482] enqueued=2.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.174625-0800 avsbartest[5880:9246482] enqueued=2.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.175007-0800 avsbartest[5880:9246482] enqueued=2.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.175411-0800 avsbartest[5880:9246482] enqueued=2.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.175749-0800 avsbartest[5880:9246482] enqueued=3.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.176188-0800 avsbartest[5880:9246482] enqueued=3.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.176575-0800 avsbartest[5880:9246482] enqueued=3.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.176916-0800 avsbartest[5880:9246482] enqueued=3.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.177274-0800 avsbartest[5880:9246482] enqueued=3.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.177684-0800 avsbartest[5880:9246482] enqueued=4.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.178053-0800 avsbartest[5880:9246482] enqueued=4.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.178381-0800 avsbartest[5880:9246482] enqueued=4.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.178783-0800 avsbartest[5880:9246482] enqueued=4.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.179097-0800 avsbartest[5880:9246482] enqueued=4.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.179496-0800 avsbartest[5880:9246482] enqueued=5.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.179851-0800 avsbartest[5880:9246482] enqueued=5.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.180110-0800 avsbartest[5880:9246482] enqueued=5.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.180330-0800 avsbartest[5880:9246482] enqueued=5.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.180560-0800 avsbartest[5880:9246482] enqueued=5.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.180804-0800 avsbartest[5880:9246482] enqueued=6.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.181059-0800 avsbartest[5880:9246482] enqueued=6.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.181298-0800 avsbartest[5880:9246482] enqueued=6.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.181529-0800 avsbartest[5880:9246482] enqueued=6.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.181783-0800 avsbartest[5880:9246482] enqueued=6.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.182016-0800 avsbartest[5880:9246482] enqueued=7.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.182305-0800 avsbartest[5880:9246482] enqueued=7.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.182601-0800 avsbartest[5880:9246482] enqueued=7.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.182830-0800 avsbartest[5880:9246482] enqueued=7.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.183046-0800 avsbartest[5880:9246482] enqueued=7.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.183361-0800 avsbartest[5880:9246482] enqueued=8.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.183573-0800 avsbartest[5880:9246482] enqueued=8.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.183831-0800 avsbartest[5880:9246482] enqueued=8.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.184090-0800 avsbartest[5880:9246482] enqueued=8.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.184372-0800 avsbartest[5880:9246482] enqueued=8.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.184636-0800 avsbartest[5880:9246482] enqueued=9.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.184842-0800 avsbartest[5880:9246482] enqueued=9.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.185099-0800 avsbartest[5880:9246482] enqueued=9.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.185329-0800 avsbartest[5880:9246482] enqueued=9.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.185559-0800 avsbartest[5880:9246482] enqueued=9.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.185861-0800 avsbartest[5880:9246482] enqueued=10.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.186071-0800 avsbartest[5880:9246482] enqueued=10.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.186397-0800 avsbartest[5880:9246482] enqueued=10.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.186625-0800 avsbartest[5880:9246482] enqueued=10.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.186882-0800 avsbartest[5880:9246482] enqueued=10.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.187096-0800 avsbartest[5880:9246482] enqueued=11.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.187333-0800 avsbartest[5880:9246482] enqueued=11.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.188591-0800 avsbartest[5880:9246465] enqueued=11.400000 time=0.000000 base=0.000000
2021-12-10 12:28:21.188888-0800 avsbartest[5880:9246465] enqueued=11.600000 time=0.000000 base=0.000000
2021-12-10 12:28:21.189108-0800 avsbartest[5880:9246465] enqueued=11.800000 time=0.000000 base=0.000000
2021-12-10 12:28:21.189326-0800 avsbartest[5880:9246465] enqueued=12.000000 time=0.000000 base=0.000000
2021-12-10 12:28:21.189559-0800 avsbartest[5880:9246465] enqueued=12.200000 time=0.000000 base=0.000000
2021-12-10 12:28:21.395920-0800 avsbartest[5880:9246328] synchronizer time = 0.000000 (enqueued = 12.200000)
2021-12-10 12:28:21.396474-0800 avsbartest[5880:9246328] synchronizer time = 0.000000 (enqueued = 12.200000)
2021-12-10 12:28:21.884213-0800 avsbartest[5880:9246328] synchronizer past zero! [0.001369]
2021-12-10 12:28:22.082711-0800 avsbartest[5880:9246328] synchronizer time = 0.200150 (enqueued = 12.200000)
starts faster this time, but still almost a second. 20.914 -> 21.884
with MAX_DELAY=0:
2021-12-10 12:29:50.220764-0800 avsbartest[5890:9247379] starting synchronizer
2021-12-10 12:29:50.268511-0800 avsbartest[5890:9247379] synchronizer rate is 1.000000
2021-12-10 12:29:50.268758-0800 avsbartest[5890:9247379] enqueued=0.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.269027-0800 avsbartest[5890:9247379] enqueued=0.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.269265-0800 avsbartest[5890:9247379] enqueued=0.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.269498-0800 avsbartest[5890:9247379] enqueued=1.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.269720-0800 avsbartest[5890:9247379] enqueued=1.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.269981-0800 avsbartest[5890:9247379] enqueued=1.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.270202-0800 avsbartest[5890:9247379] enqueued=1.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.270451-0800 avsbartest[5890:9247379] enqueued=1.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.270671-0800 avsbartest[5890:9247379] enqueued=2.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.271175-0800 avsbartest[5890:9247379] enqueued=2.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.271379-0800 avsbartest[5890:9247379] enqueued=2.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.271578-0800 avsbartest[5890:9247379] enqueued=2.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.271887-0800 avsbartest[5890:9247379] enqueued=2.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.272093-0800 avsbartest[5890:9247379] enqueued=3.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.272294-0800 avsbartest[5890:9247379] enqueued=3.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.272616-0800 avsbartest[5890:9247379] enqueued=3.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.273042-0800 avsbartest[5890:9247379] enqueued=3.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.273309-0800 avsbartest[5890:9247379] enqueued=3.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.273512-0800 avsbartest[5890:9247379] enqueued=4.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.273753-0800 avsbartest[5890:9247379] enqueued=4.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.274004-0800 avsbartest[5890:9247379] enqueued=4.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.274216-0800 avsbartest[5890:9247379] enqueued=4.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.274607-0800 avsbartest[5890:9247379] enqueued=4.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.274824-0800 avsbartest[5890:9247379] enqueued=5.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.275020-0800 avsbartest[5890:9247379] enqueued=5.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.275721-0800 avsbartest[5890:9247379] enqueued=5.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.275988-0800 avsbartest[5890:9247379] enqueued=5.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.276414-0800 avsbartest[5890:9247379] enqueued=5.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.276662-0800 avsbartest[5890:9247379] enqueued=6.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.276864-0800 avsbartest[5890:9247379] enqueued=6.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.277069-0800 avsbartest[5890:9247379] enqueued=6.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.277331-0800 avsbartest[5890:9247379] enqueued=6.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.277535-0800 avsbartest[5890:9247379] enqueued=6.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.277846-0800 avsbartest[5890:9247379] enqueued=7.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.278049-0800 avsbartest[5890:9247379] enqueued=7.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.278847-0800 avsbartest[5890:9247379] enqueued=7.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.279115-0800 avsbartest[5890:9247379] enqueued=7.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.279316-0800 avsbartest[5890:9247379] enqueued=7.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.279608-0800 avsbartest[5890:9247379] enqueued=8.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.279907-0800 avsbartest[5890:9247379] enqueued=8.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.280148-0800 avsbartest[5890:9247379] enqueued=8.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.280503-0800 avsbartest[5890:9247379] enqueued=8.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.280692-0800 avsbartest[5890:9247379] enqueued=8.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.280973-0800 avsbartest[5890:9247379] enqueued=9.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.281352-0800 avsbartest[5890:9247379] enqueued=9.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.281934-0800 avsbartest[5890:9247379] enqueued=9.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.282196-0800 avsbartest[5890:9247379] enqueued=9.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.282384-0800 avsbartest[5890:9247379] enqueued=9.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.282568-0800 avsbartest[5890:9247379] enqueued=10.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.282821-0800 avsbartest[5890:9247379] enqueued=10.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.283012-0800 avsbartest[5890:9247379] enqueued=10.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.283407-0800 avsbartest[5890:9247379] enqueued=10.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.283606-0800 avsbartest[5890:9247379] enqueued=10.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.283804-0800 avsbartest[5890:9247379] enqueued=11.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.284028-0800 avsbartest[5890:9247379] enqueued=11.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.285048-0800 avsbartest[5890:9247379] enqueued=11.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.285271-0800 avsbartest[5890:9247379] enqueued=11.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.285464-0800 avsbartest[5890:9247379] enqueued=11.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.285742-0800 avsbartest[5890:9247379] enqueued=12.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.285959-0800 avsbartest[5890:9247379] enqueued=12.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.286154-0800 avsbartest[5890:9247379] enqueued=12.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.286434-0800 avsbartest[5890:9247379] enqueued=12.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.286840-0800 avsbartest[5890:9247379] enqueued=12.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.287133-0800 avsbartest[5890:9247379] enqueued=13.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.288290-0800 avsbartest[5890:9247379] enqueued=13.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.288506-0800 avsbartest[5890:9247379] enqueued=13.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.288702-0800 avsbartest[5890:9247379] enqueued=13.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.288925-0800 avsbartest[5890:9247379] enqueued=13.800000 time=0.000000 base=0.000000
2021-12-10 12:29:50.289175-0800 avsbartest[5890:9247379] enqueued=14.000000 time=0.000000 base=0.000000
2021-12-10 12:29:50.289372-0800 avsbartest[5890:9247379] enqueued=14.200000 time=0.000000 base=0.000000
2021-12-10 12:29:50.289573-0800 avsbartest[5890:9247379] enqueued=14.400000 time=0.000000 base=0.000000
2021-12-10 12:29:50.289832-0800 avsbartest[5890:9247379] enqueued=14.600000 time=0.000000 base=0.000000
2021-12-10 12:29:50.642645-0800 avsbartest[5890:9247235] synchronizer time = 0.000000 (enqueued = 14.600000)
2021-12-10 12:29:50.643251-0800 avsbartest[5890:9247235] synchronizer time = 0.000000 (enqueued = 14.600000)
2021-12-10 12:29:50.989832-0800 avsbartest[5890:9247235] synchronizer past zero! [0.000515]
2021-12-10 12:29:51.024689-0800 avsbartest[5890:9247375] enqueued=14.800000 time=0.035394 base=0.035402
feeding into AVSBAR continuously with no limits results in the fastest playback start, but still takes 700ms: 50.220 -> 50.989