10/28/2017 15:37:38 - ------------------------------------------------------------
10/28/2017 15:37:38 - /opt/RoonReady/raatool logdump 84f185ff-d488-4281-a0da-84c63db0ac96
[0000000] 0.000 TRACE [info] initializing info dictionary
[0000001] 0.005 TRACE [info] inserting raat_version -> 1.1.21
[0000002] 0.007 TRACE [info] inserting protocol_version -> 3
[0000003] 0.017 TRACE [output/alsa] initializing output uniqueid=hw:0,0
[0000004] 0.022 TRACE [output/alsa] preferred buffer duration=0.050000s
[0000005] 0.024 TRACE [output/alsa] force_max_volume=0
[0000006] 0.026 TRACE [output/alsa] resync delay=0.100000s
[0000007] 0.028 TRACE [ALSA] max pcm rate=1411200
[0000008] 0.028 TRACE [output/alsa] max dsd rate=1024
[0000009] 0.028 TRACE [output/alsa] dsd_mode=native
[0000010] 0.028 TRACE [output/alsa] getting hardware info
[0000011] 0.029 TRACE pcm card id DAC
[0000012] 0.029 TRACE pcm card name OPPO HA-2 USB AUDIO 2.0 DAC
[0000013] 0.029 TRACE pcm card longname OPPO OPPO HA-2 USB AUDIO 2.0 DAC at usb-ci_hdrc.1-1.1, high speed
[0000014] 0.029 TRACE pcm card mixername USB Mixer
[0000015] 0.029 TRACE pcm card components USB22d9:0426
[0000016] 0.029 TRACE pcm card driver USB-Audio
[0000017] 0.029 TRACE pcm card usb id 22d9:0426
[0000018] 0.030 TRACE [output/alsa] probing formats
[0000019] 0.038 TRACE [alsa] [hw:0,0] probing formats
[0000020] 0.038 TRACE [alsa] [hw:0,0] device supports channels range 2-2
[0000021] 0.038 TRACE [alsa] [hw:0,0] supports DSD format 2822400/1/1 (Native)
[0000022] 0.038 TRACE [alsa] [hw:0,0] supports DSD format 5644800/1/1 (Native)
[0000023] 0.038 TRACE [alsa] [hw:0,0] supports DSD format 11289600/1/1 (Native)
[0000024] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 44100/16/1
[0000025] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 44100/24/1
[0000026] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 44100/32/1
[0000027] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 48000/16/1
[0000028] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 48000/24/1
[0000029] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 48000/32/1
[0000030] 0.039 TRACE [alsa] [hw:0,0] supports PCM format 88200/16/1
[0000031] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 88200/24/1
[0000032] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 88200/32/1
[0000033] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 96000/16/1
[0000034] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 96000/24/1
[0000035] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 96000/32/1
[0000036] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 176400/16/1
[0000037] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 176400/24/1
[0000038] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 176400/32/1
[0000039] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 192000/16/1
[0000040] 0.040 TRACE [alsa] [hw:0,0] supports PCM format 192000/24/1
[0000041] 0.041 TRACE [alsa] [hw:0,0] supports PCM format 192000/32/1
[0000042] 0.041 TRACE [alsa] [hw:0,0] supports PCM format 352800/16/1
[0000043] 0.044 TRACE [alsa] [hw:0,0] supports PCM format 352800/24/1
[0000044] 0.044 TRACE [alsa] [hw:0,0] supports PCM format 352800/32/1
[0000045] 0.045 TRACE [alsa] [hw:0,0] supports PCM format 384000/16/1
[0000046] 0.045 TRACE [alsa] [hw:0,0] supports PCM format 384000/24/1
[0000047] 0.045 TRACE [alsa] [hw:0,0] supports PCM format 384000/32/1
[0000048] 0.045 TRACE [alsa] [hw:0,0] supports DSD format 2822400/1/2 (Native)
[0000049] 0.045 TRACE [alsa] [hw:0,0] supports DSD format 5644800/1/2 (Native)
[0000050] 0.046 TRACE [alsa] [hw:0,0] supports DSD format 11289600/1/2 (Native)
[0000051] 0.046 TRACE [alsa] [hw:0,0] supports PCM format 44100/16/2
[0000052] 0.046 TRACE [alsa] [hw:0,0] supports PCM format 44100/24/2
[0000053] 0.046 TRACE [alsa] [hw:0,0] supports PCM format 44100/32/2
[0000054] 0.046 TRACE [alsa] [hw:0,0] supports PCM format 48000/16/2
[0000055] 0.046 TRACE [alsa] [hw:0,0] supports PCM format 48000/24/2
[0000056] 0.047 TRACE [alsa] [hw:0,0] supports PCM format 48000/32/2
[0000057] 0.048 TRACE [alsa] [hw:0,0] supports PCM format 88200/16/2
[0000058] 0.048 TRACE [alsa] [hw:0,0] supports PCM format 88200/24/2
[0000059] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 88200/32/2
[0000060] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 96000/16/2
[0000061] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 96000/24/2
[0000062] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 96000/32/2
[0000063] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 176400/16/2
[0000064] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 176400/24/2
[0000065] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 176400/32/2
[0000066] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 192000/16/2
[0000067] 0.049 TRACE [alsa] [hw:0,0] supports PCM format 192000/24/2
[0000068] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 192000/32/2
[0000069] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 352800/16/2
[0000070] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 352800/24/2
[0000071] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 352800/32/2
[0000072] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 384000/16/2
[0000073] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 384000/24/2
[0000074] 0.050 TRACE [alsa] [hw:0,0] supports PCM format 384000/32/2
[0000075] 0.079 TRACE [output/alsa] initialized
[0000076] 0.079 INFO [volume/alsa] initializing
[0000077] 0.079 TRACE [volume/alsa] [hw:0] Settings
[0000078] 0.079 TRACE [volume/alsa] [hw:0] mixer index: 0
[0000079] 0.081 TRACE [volume/alsa] searching for volume control element
[0000080] 0.081 TRACE [volume/alsa] card has element 0, OPPO HA-2 USB AUDIO 2.0 DAC Input Playback
[0000081] 0.081 TRACE [volume/alsa] (skipping: element doesn’t support playback volume)
[0000082] 0.081 TRACE [volume/alsa] card has element 1, OPPO HA-2 USB AUDIO 2.0 DAC Input Playback
[0000083] 0.081 TRACE [volume/alsa] (skipping: element doesn’t match ‘index’ from JSON configuration)
[0000084] 0.081 TRACE [volume/alsa] card has element 0, OPPO Internal Clock Validity
[0000085] 0.081 TRACE [volume/alsa] (skipping: element doesn’t support playback volume)
[0000086] 0.081 ERROR [volume/alsa] couldn’t find mixer element
[0000087] 0.081 TRACE [watch/alsa] initializing watch device=hw:0 exit_on_lost=1
[0000088] 0.081 TRACE [watch/alsa] initialized
[0000089] 0.082 TRACE [info] inserting unique_id -> 84f185ff-d488-4281-a0da-84c63db0ac96
[0000090] 0.082 TRACE [info] inserting vendor -> Sonore
[0000091] 0.082 TRACE [info] inserting serial -> 01028C
[0000092] 0.082 TRACE [info] inserting config_url -> http://SELF/
[0000093] 0.082 TRACE [info] inserting model -> microRendu
[0000094] 0.082 TRACE [info] inserting version -> 1.1.22
[0000095] 0.082 INFO [server] listening on port 43837
[0000096] 0.082 TRACE [discovery] starting
[0000097] 0.083 INFO [discovery] [iface:127.0.0.1] multicast recv socket is bound to 0.0.0.0:9003
[0000098] 0.083 INFO [discovery] [iface:127.0.0.1] multicast send socket is bound to 0.0.0.0:37650
[0000099] 0.083 INFO [discovery] [iface:10.0.1.140] multicast recv socket is bound to 0.0.0.0:9003
[0000100] 0.084 INFO [discovery] [iface:10.0.1.140] multicast send socket is bound to 0.0.0.0:59230
[0000101] 0.088 INFO [discovery] unicast socket is bound to 0.0.0.0:9003
[0000102] 0.088 TRACE [device] announcing DiscoveryMessage[type=QUERY, transactionid=3E972AA8-62BE-0938-ECFB-E940A5796FDB, Data={ “unique_id”: “84f185ff-d488-4281-a0da-84c63db0ac96”, “raat_version”: “1.1.21”, “vendor”: “Sonore”, “protocol_version”: “3”, “serial”: “01028C”, “model”: “microRendu”, “version”: “1.1.22”, “config_url”: “http://SELF/”, “service_id”: “5e2042ad-9bc5-4508-be92-ff68f19bdc93”, “tcp_port”: “43837”, } ]
[0000103] 0.374 TRACE [server] [10.0.1.127:58564] accepted connection
[0000104] 0.384 TRACE [session] [10.0.1.127:58564] created: 0xd4dad8 (0xd4eef8)
[0000105] 0.393 TRACE [server] new script with name=raat.dat:base.lua module=base
[0000106] 0.396 TRACE [session] [10.0.1.127:58564] pre-loading lua module base
[0000107] 0.411 TRACE [server] new script with name=raat.dat:dkjson.lua module=dkjson
[0000108] 0.413 TRACE [session] [10.0.1.127:58564] pre-loading lua module dkjson
[0000109] 0.424 TRACE [server] new script with name=raat.dat:protocol.lua module=protocol
[0000110] 0.445 TRACE [session] [10.0.1.127:58564] pre-loading lua module protocol
[0000111] 0.460 TRACE [server] new script with name=raat.dat:roon_tcp.lua module=(null)
[0000112] 0.463 TRACE [session] [10.0.1.127:58564] executing lua script
[0000113] 0.474 TRACE [server] [10.0.1.127:58564] SENT[LL] [1] {“status”: “Success”}
[0000114] 0.484 TRACE [server] [10.0.1.127:58564] SENT[LL] [2] {“status”: “Success”}
[0000115] 0.487 TRACE [server] [10.0.1.127:58564] SENT[LL] [3] {“status”: “Success”}
[0000116] 0.527 WARNING [lua@0xd4dcc4] [10.0.1.127:58564] failed set recv buffer size: nil
[0000117] 0.530 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] [roon] clock socket listening on udp 0.0.0.0:50544
[0000118] 0.536 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] [roon] audio socket listening on tcp 0.0.0.0:45289
[0000119] 0.536 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] [roon] output info {“config”: {“type”: “alsa”, “device”: “hw:0,0”, “dsd_mode”: “native”, “signal_path”: [{“quality”: “lossless”, “type”: “output”, “method”: “usb”}], “buffer_duration”: 0.050000000000000003}, “alsa_device”: {“name”: “OPPO HA-2 USB AUDIO 2.0 DAC”, “id”: “DAC”, “driver”: “USB-Audio”, “longname”: “OPPO OPPO HA-2 USB AUDIO 2.0 DAC at usb-ci_hdrc.1-1.1, high speed”, “mixername”: “USB Mixer”, “components”: “DAC”, “usbid”: “22d9:0426”}}
[0000120] 0.536 TRACE [server] [10.0.1.127:58564] SENT[LL] [4] {“status”: “Success”}
[0000121] 0.738 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] GOT [2] {“request”:“info”}
[0000122] 0.747 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] SENT [2] {“flags”:{“has_write_chmap”:true},“transport”:{“info”:[],“is_supported”:false},“platform”:{“uname”:{“release”:“4.12.13-200.fc25.armv7hl”,“sysname”:“Linux”,“version”:"#1 SMP Tue Sep 26 17:54:27 EDT 2017",“machine”:“armv7l”,“nodename”:“livingroom”},“os”:“linux”},“info”:{“unique_id”:“84f185ff-d488-4281-a0da-84c63db0ac96”},“volume”:{“info”:[],“is_supported”:false},“output”:{“supported_formats”:“48000/16/1|2,44100/24/1|2,352800/32/1|2,96000/24/1|2,192000/16/1|2,88200/32/1|2,88200/16/1|2,48000/24/1|2,176400/32/1|2,5644800/1/1|2,192000/24/1|2,44100/32/1|2,384000/32/1|2,352800/24/1|2,384000/16/1|2,176400/16/1|2,384000/24/1|2,48000/32/1|2,176400/24/1|2,192000/32/1|2,96000/16/1|2,352800/16/1|2,96000/32/1|2,2822400/1/1|2,88200/24/1|2,11289600/1/1|2,44100/16/1|2”,“info”:{“alsa_device”:{“longname”:“OPPO OPPO HA-2 USB AUDIO 2.0 DAC at usb-ci_hdrc.1-1.1, high speed”,“usbid”:“22d9:0426”,“name”:“OPPO HA-2 USB AUDIO 2.0 DAC”,“driver”:“USB-Audio”,“mixername”:“USB Mixer”,“components”:
[0000123] 0.748 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] GOT [3] {“request”:“set_client_type”,“client_type”:“Roon”}
[0000124] 0.749 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] SENT [3] {“status”:“Success”}
[0000125] 0.950 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] GOT [4] {“request”:“subscribe_transport”}
[0000126] 0.951 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] GOT [5] {“request”:“subscribe_controls”,“controller_id”:“0cf722d4-8e5c-4440-9efc-63bc11a955f3”}
[0000127] 0.952 TRACE [lua@0xd4dcc4] [10.0.1.127:58564] SENT [5] {“action”:“Changed”,“controls”:[],“status”:“Success”}
[0000128] 7717.515 TRACE Network Status Changed. Refreshing Discovery
[0000129] 7717.515 TRACE [discovery] stopping
[0000130] 7717.516 TRACE closing multicast
[0000131] 7717.516 TRACE [discovery] closing unicast send socket
[0000132] 7717.516 TRACE [discovery] closing unicast recv socket
[0000133] 7717.516 TRACE [discovery] starting
[0000134] 7717.517 INFO [discovery] [iface:127.0.0.1] multicast recv socket is bound to 0.0.0.0:9003
[0000135] 7717.517 INFO [discovery] [iface:127.0.0.1] multicast send socket is bound to 0.0.0.0:59499
[0000136] 7717.517 INFO [discovery] [iface:10.0.1.144] multicast recv socket is bound to 0.0.0.0:9003
[0000137] 7717.517 INFO [discovery] [iface:10.0.1.144] multicast send socket is bound to 0.0.0.0:60577
[0000138] 7717.517 INFO [discovery] unicast socket is bound to 0.0.0.0:9003
[0000139] 7717.517 TRACE [device] announcing DiscoveryMessage[type=QUERY, transactionid=DF982E90-C339-D622-B47D-418E6626A7B7, Data={ “unique_id”: “84f185ff-d488-4281-a0da-84c63db0ac96”, “raat_version”: “1.1.21”, “vendor”: “Sonore”, “protocol_version”: “3”, “serial”: “01028C”, “model”: “microRendu”, “version”: “1.1.22”, “config_url”: “http://SELF/”, “service_id”: “5e2042ad-9bc5-4508-be92-ff68f19bdc93”, “tcp_port”: “43837”, } ]
[0000140] 7717.523 TRACE Network Status Changed. Refreshing Discovery
[0000141] 7717.523 TRACE [discovery] stopping
[0000142] 7717.523 TRACE closing multicast
[0000143] 7717.523 TRACE [discovery] closing unicast send socket
[0000144] 7717.523 TRACE [discovery] closing unicast recv socket
[0000145] 7717.523 TRACE [discovery] starting
[0000146] 7717.524 INFO [discovery] [iface:127.0.0.1] multicast recv socket is bound to 0.0.0.0:9003
[0000147] 7717.524 INFO [discovery] [iface:127.0.0.1] multicast send socket is bound to 0.0.0.0:36791
[0000148] 7717.524 INFO [discovery] [iface:10.0.1.144] multicast recv socket is bound to 0.0.0.0:9003
[0000149] 7717.525 INFO [discovery] [iface:10.0.1.144] multicast send socket is bound to 0.0.0.0:45134
[0000150] 7717.525 INFO [discovery] unicast socket is bound to 0.0.0.0:9003
[0000151] 7717.525 TRACE [device] announcing DiscoveryMessage[type=QUERY, transactionid=AC3E25C2-48CF-C50C-13B9-99221039D66B, Data={ “unique_id”: “84f185ff-d488-4281-a0da-84c63db0ac96”, “raat_version”: “1.1.21”, “vendor”: “Sonore”, “protocol_version”: “3”, “serial”: “01028C”, “model”: “microRendu”, “version”: “1.1.22”, “config_url”: “http://SELF/”, “service_id”: “5e2042ad-9bc5-4508-be92-ff68f19bdc93”, “tcp_port”: “43837”, } ]
[0000152] 7717.530 ERROR [discovery] error sending response: operation canceled
[0000153] 7717.530 ERROR [discovery] error sending response: operation canceled
[0000154] 7717.530 ERROR [discovery] error sending response: operation canceled
[0000155] 7717.530 ERROR [discovery] error sending response: operation canceled
[0000156] 7717.531 ERROR [discovery] error sending response: operation canceled
[0000157] 7717.531 DEBUG [discovery] broadcast op canceled, deleting it
[0000158] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000159] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000160] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000161] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000162] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000163] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000164] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000165] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000166] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000167] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000168] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000169] 7717.531 ERROR [discovery] error sending rebroadcast: operation canceled
[0000170] 7725.186 WARNING [server] client timed out after 10399ms (timeout=10000)
[0000171] 7725.187 TRACE [server] [10.0.1.127:58564] destroying client
[0000172] 7725.187 TRACE [session] [10.0.1.127:58564] destroying session
[0000173] 7726.588 TRACE [server] [10.0.1.127:59826] accepted connection
[0000174] 7726.594 TRACE [session] [10.0.1.127:59826] created: 0xd3e9a0 (0xd654b8)
[0000175] 7726.605 TRACE [server] new script with name=raat.dat:base.lua module=base
[0000176] 7726.608 TRACE [session] [10.0.1.127:59826] pre-loading lua module base
[0000177] 7726.617 TRACE [server] new script with name=raat.dat:dkjson.lua module=dkjson
[0000178] 7726.618 TRACE [session] [10.0.1.127:59826] pre-loading lua module dkjson
[0000179] 7726.622 TRACE [server] new script with name=raat.dat:protocol.lua module=protocol
[0000180] 7726.632 TRACE [session] [10.0.1.127:59826] pre-loading lua module protocol
[0000181] 7726.641 TRACE [server] new script with name=raat.dat:roon_tcp.lua module=(null)
[0000182] 7726.642 TRACE [server] [10.0.1.127:59826] SENT[LL] [1] {“status”: “Success”}
[0000183] 7726.642 TRACE [session] [10.0.1.127:59826] executing lua script
[0000184] 7726.643 TRACE [server] [10.0.1.127:59826] SENT[LL] [2] {“status”: “Success”}
[0000185] 7726.643 TRACE [server] [10.0.1.127:59826] SENT[LL] [3] {“status”: “Success”}
[0000186] 7726.668 WARNING [lua@0xd54e84] [10.0.1.127:59826] failed set recv buffer size: nil
[0000187] 7726.668 TRACE [lua@0xd54e84] [10.0.1.127:59826] [roon] clock socket listening on udp 0.0.0.0:59784
[0000188] 7726.668 TRACE [lua@0xd54e84] [10.0.1.127:59826] [roon] audio socket listening on tcp 0.0.0.0:43475
[0000189] 7726.669 TRACE [lua@0xd54e84] [10.0.1.127:59826] [roon] output info {“config”: {“type”: “alsa”, “device”: “hw:0,0”, “dsd_mode”: “native”, “signal_path”: [{“quality”: “lossless”, “type”: “output”, “method”: “usb”}], “buffer_duration”: 0.050000000000000003}, “alsa_device”: {“name”: “OPPO HA-2 USB AUDIO 2.0 DAC”, “id”: “DAC”, “driver”: “USB-Audio”, “longname”: “OPPO OPPO HA-2 USB AUDIO 2.0 DAC at usb-ci_hdrc.1-1.1, high speed”, “mixername”: “USB Mixer”, “components”: “DAC”, “usbid”: “22d9:0426”}}
[0000190] 7726.669 TRACE [server] [10.0.1.127:59826] SENT[LL] [4] {“status”: “Success”}
[0000191] 7726.870 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [2] {“request”:“info”}
[0000192] 7726.879 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [2] {“flags”:{“has_write_chmap”:true},“source_selection”:{“is_supported”:false,“info”:[]},“platform”:{“os”:“linux”,“uname”:{“sysname”:“Linux”,“version”:"#1 SMP Tue Sep 26 17:54:27 EDT 2017",“release”:“4.12.13-200.fc25.armv7hl”,“machine”:“armv7l”,“nodename”:“livingroom”}},“transport”:{“is_supported”:false,“info”:[]},“info”:{“unique_id”:“84f185ff-d488-4281-a0da-84c63db0ac96”},“status”:“Success”,“volume”:{“is_supported”:false,“info”:[]},“output”:{“info”:{“alsa_device”:{“usbid”:“22d9:0426”,“id”:“DAC”,“name”:“OPPO HA-2 USB AUDIO 2.0 DAC”,“mixername”:“USB Mixer”,“components”:“DAC”,“driver”:“USB-Audio”,“longname”:“OPPO OPPO HA-2 USB AUDIO 2.0 DAC at usb-ci_hdrc.1-1.1, high speed”},“config”:{“dsd_mode”:“native”,“buffer_duration”:0.05,“device”:“hw:0,0”,“signal_path”:[{“method”:“usb”,“type”:“output”,“quality”:“lossless”}],“type”:“alsa”}},“supported_formats”:"96000/32/1|2,88200/24/1|2,192000/32/1|2,48000/32/1|2,176400/16/1|2,192000/16/1|2,2822400/1/1|2,384000/32/1|2,352800/24/1|2
[0000193] 7726.880 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [3] {“request”:“set_client_type”,“client_type”:“Roon”}
[0000194] 7726.880 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [3] {“status”:“Success”}
[0000195] 7727.082 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [4] {“request”:“subscribe_transport”}
[0000196] 7727.083 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [5] {“request”:“subscribe_controls”,“controller_id”:“0cf722d4-8e5c-4440-9efc-63bc11a955f3”}
[0000197] 7727.084 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [5] {“status”:“Success”,“action”:“Changed”,“controls”:[]}
[0000198] 14822.627 DEBUG [discovery] broadcast op is complete
[0000199] 14847.821 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [6] {“request”:“setup”,“format”:{“sample_type”:“pcm”,“sample_rate”:384000,“bits_per_sample”:32,“channels”:2,“sample_subtype”:“none”}}
[0000200] 14847.821 TRACE alsa output setup: format is pcm 384000/32/2
[0000201] 14847.821 TRACE opening [hw:0,0] 384000/32/2
[0000202] 14847.822 TRACE prefer larger samples = 0
[0000203] 14847.823 TRACE [ALSA] [hw:0,0] using hw pcmformat S32_LE bitspersample 32
[0000204] 14847.823 TRACE [ALSA] [hw:0,0] Requesting 2 periods
[0000205] 14847.823 TRACE [ALSA] [hw:0,0] Requesting 19200 frames/buffer (9600 frames/period)
[0000206] 14847.823 TRACE [ALSA] [hw:0,0] Initialized with 2 periods with 9600 frames/period and 19200 frames/buffer
[0000207] 14847.832 TRACE sched_setscheduler succeeded
[0000208] 14847.832 TRACE samples per buf 9600 ns per buf 25000000 samplerate 384000
[0000209] 14847.832 TRACE 9600 samples per buf, 76800 bytes per buf, 76800 bytes per hwbuf
[0000210] 14847.832 TRACE [lua@0xd54e84] [10.0.1.127:59826] got output message {“signal_path”: [{“quality”: “lossless”, “type”: “output”, “method”: “usb”}]}
[0000211] 14847.832 TRACE [output/alsa] [hw:0,0] waiting for device to be ready
[0000212] 14847.833 TRACE [output/alsa] [hw:0,0] device is ready
[0000213] 14847.834 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [6] {“message”:{“signal_path”:[{“method”:“usb”,“type”:“output”,“quality”:“lossless”}]},“status”:“OutputMessage”}
[0000214] 14847.865 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [6] {“clock_port”:59784,“status”:“Success”,“audio_port”:0,“audio_port_tcp”:43475}
[0000215] 14848.102 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [7] {“request”:“stream”,“stream_id”:1057795017,“first_seq”:-1,“nak_port”:-1,“buffer_size”:5}
[0000216] 14848.102 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [7] {“status”:“Buffering”}
[0000217] 14848.351 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [7] {“status”:“Ready”}
[0000218] 14848.560 TRACE [lua@0xd54e84] [10.0.1.127:59826] GOT [8] {“request”:“start”,“min_offset”:69125000,“stream_sample”:0}
[0000219] 14848.560 TRACE [lua@0xd54e84] [10.0.1.127:59826] Doing ASAP start based on current device clock (min_offset=69125000)
[0000220] 14848.560 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [7] {“status”:“Playing”}
[0000221] 14848.561 TRACE [lua@0xd54e84] [10.0.1.127:59826] SENT [8] {“time”:815306272,“status”:“Success”}
[0000222] 14848.563 TRACE starting playback: now (800000000ns) + ns_per_buf(25000000ns) = 825000000ns > 815306272ns streamsample=0
[0000223] 15325.775 TRACE [server] [127.0.0.1:59452] accepted connection
[0000224] 15325.782 TRACE [session] [127.0.0.1:59452] created: 0xd688c0 (0xddff20)
10/28/2017 15:37:38 - ------------------------------------------------------------
10/28/2017 15:37:38 - aplay -l
**** List of PLAYBACK Hardware Devices ****
card 0: DAC [OPPO HA-2 USB AUDIO 2.0 DAC], device 0: USB Audio [USB Audio]
Subdevices: 0/1
Subdevice #0: subdevice #0