RoonReady Diagnostic information BACK to Menu
05/17/2016 16:22:55 - ------------------------------------------------------------
05/17/2016 16:22:55 - /opt/RoonReady/raatool logdump 53de81c0-345c-439b-8045-4999c27bd5e5
[0000000] 0.005 TRACE [info] initializing info dictionary
[0000001] 0.006 TRACE [info] inserting raat_version -> 1.0.18
[0000002] 0.006 TRACE [info] inserting protocol_version -> 3
[0000003] 0.025 TRACE [ALSA] initializing output uniqueid=hw:0,0
[0000004] 0.025 TRACE [ALSA] preferred buffer duration=0.100000s
[0000005] 0.025 TRACE [ALSA] resync delay=0.100000s
[0000006] 0.025 TRACE [ALSA] max pcm rate=384000
[0000007] 0.025 TRACE [ALSA] max dsd rate=128
[0000008] 0.025 TRACE [ALSA] dsd_mode=none
[0000009] 0.025 TRACE [output/alsa] getting hardware info
[0000010] 0.026 TRACE pcm card id SPDIF
[0000011] 0.026 TRACE pcm card name Integrated SPDIF
[0000012] 0.026 TRACE pcm card longname Integrated SPDIF
[0000013] 0.026 TRACE pcm card mixername
[0000014] 0.026 TRACE pcm card components
[0000015] 0.026 TRACE pcm card driver Integrated_SPDI
[0000016] 0.026 TRACE [output/alsa] probing formats
[0000017] 0.027 TRACE [alsa] [hw:0,0] probing formats
[0000018] 0.027 TRACE [alsa] [hw:0,0] device supports channels range 2-2
[0000019] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 44100/16/1
[0000020] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 44100/24/1
[0000021] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 48000/16/1
[0000022] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 48000/24/1
[0000023] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 88200/16/1
[0000024] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 88200/24/1
[0000025] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 96000/16/1
[0000026] 0.027 TRACE [alsa] [hw:0,0] supports PCM format 96000/24/1
[0000027] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 176400/16/1
[0000028] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 176400/24/1
[0000029] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 192000/16/1
[0000030] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 192000/24/1
[0000031] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 44100/16/2
[0000032] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 44100/24/2
[0000033] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 48000/16/2
[0000034] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 48000/24/2
[0000035] 0.028 TRACE [alsa] [hw:0,0] supports PCM format 88200/16/2
[0000036] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 88200/24/2
[0000037] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 96000/16/2
[0000038] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 96000/24/2
[0000039] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 176400/16/2
[0000040] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 176400/24/2
[0000041] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 192000/16/2
[0000042] 0.029 TRACE [alsa] [hw:0,0] supports PCM format 192000/24/2
[0000043] 0.029 TRACE [output/alsa] initialized
[0000044] 0.029 TRACE [volume/software] preferred max attenuation=-100s
[0000045] 0.030 TRACE [volume/software] initialized
[0000046] 0.030 TRACE [watch/alsa] initializing watch device=hw:0 exit_on_lost=1
[0000047] 0.030 TRACE [watch/alsa] initialized
[0000048] 0.030 TRACE [info] inserting unique_id -> 53de81c0-345c-439b-8045-4999c27bd5e5
[0000049] 0.030 TRACE [info] inserting vendor -> Sonore
[0000050] 0.030 TRACE [info] inserting output_name -> SPDIF digital (optical)
[0000051] 0.030 TRACE [info] inserting serial -> 00BCE4
[0000052] 0.030 TRACE [info] inserting config_url -> http://__SELF__/
[0000053] 0.030 TRACE [info] inserting model -> Sonicorbiter SE
[0000054] 0.030 TRACE [info] inserting version -> 1.0.18
[0000055] 0.030 INFO [server] listening on port 45917
[0000056] 0.030 INFO [discovery] unicast socket is bound to 0.0.0.0:40891
[0000057] 0.031 INFO [discovery] multicast socket is bound to 0.0.0.0:11043
[0000058] 0.031 TRACE [device] announcing
DiscoveryMessage[type=QUERY,
transactionid=BF3ED89C-EEF9-F982-0CE2-0861EE6AB123, Data={ "unique_id":
"53de81c0-345c-439b-8045-4999c27bd5e5", "raat_version": "1.0.18",
"vendor": "Sonore", "protocol_version": "3", "serial": "00BCE4",
"output_name": "SPDIF digital (optical)", "version": "1.0.18", "model":
"Sonicorbiter SE", "config_url": "http://__SELF__/", "service_id":
"5e2042ad-9bc5-4508-be92-ff68f19bdc93", "tcp_port": "45917", } ]
[0000059] 0.052 TRACE [server] [192.168.0.14:33763] accepted connection
[0000060] 0.068 TRACE [session] [192.168.0.14:33763] starting
[0000061] 0.068 TRACE [session] [192.168.0.14:33763] [internal] executing lua script
[0000062] 0.070 TRACE [session] [192.168.0.14:33763] [internal] executing lua script
[0000063] 0.070 TRACE [session] [192.168.0.14:33763] created
[0000064] 0.101 TRACE [server] [192.168.0.14:33763] GOT[LL] [1]
{"request":"load_script","sha256":"foo","script":"local base = {
}\n\nlocal next_subscription_id_gen = 1\n\nfunction
base.subscribe(table, request, cx) \n local subscription =
request.subscription\n if not subscription then\n subscription
= \"__uniq__\" .. next_subscription_id_gen .. \"__uniq__\"\n
next_subscription_id_gen = next_subscription_id_gen + 1\n end\n
table[subscription] = cx\nend\n\nfunction base.unsubscribe(table,
request, cx) \n if request.subscription and
table[request.subscription] then\n table[request.subscription] =
nil\n cx:respond({ status = \"Success\" })\n return\n
end\n cx:respond({ status = \"NotFound\" })\nend\n\nfunction
addr_tostring(addr)\n return tostring(addr.ip) .. \":\" ..
tostring(addr.port)\nend\n\nreturn
base\n","module":"base","name":"raat.dat:base.lua"}
[0000065] 0.102 TRACE [server] new script with name=raat.dat:base.lua module=base
[0000066] 0.115 TRACE [session] [192.168.0.14:33763] pre-loading lua module base
[0000067] 0.129 TRACE [server] [192.168.0.14:33763] GOT[LL] [2]
{"request":"load_script","sha256":"foo","script":"-- Module
options:\nlocal always_try_using_lpeg = true\nlocal
register_global_module_table = false\nlocal global_module_name =
'json'\n\n--[==[\n\nDavid Kolf's JSON module for Lua 5.1/5.2\n\nVersion
2.5\n\n\nFor the documentation see the corresponding readme.txt or
visit\n.\n\nYou
can contact the author by sending an e-mail to 'david' at the\ndomain
'dkolf.de'.\n\n\nCopyright (C) 2010-2014 David Heiko Kolf\n\nPermission
is hereby granted, free of charge, to any person obtaining\na copy of
this software and associated documentation files (the\n\"Software\"), to
deal in the Software without restriction, including\nwithout limitation
the rights to use, copy, modify, merge, publish,\ndistribute,
sublicense, and/or sell copies of the Software, and to\npermit persons
to whom the Software is furnished to do so, subject to\nthe following
conditions:\n\nThe above copyright notice and this p
[0000068] 0.130 TRACE [server] new script with name=raat.dat:dkjson.lua module=dkjson
[0000069] 0.130 TRACE [session] [192.168.0.14:33763] pre-loading lua module dkjson
[0000070] 0.146 TRACE [server] [192.168.0.14:33763] GOT[LL] [3]
{"request":"load_script","sha256":"foo","script":"local base =
require(\"base\")\nlocal json = require(\"dkjson\")\n\nlocal
protocol = { }\n\nlocal REQUEST = 0x00000001\nlocal RESPONSE
= 0x00000002\nlocal ARTWORK =
0x00000003\n\nprotocol.on_request = function (cx, r)
end\n\nRequestContext = { }\nRequestContext.__index =
RequestContext\n\nfunction RequestContext.new(rid,quiet)\n local self
= setmetatable({}, RequestContext)\n self.rid = rid\n self.quiet =
quiet\n self.did_final_response = false\n return
self\nend\n\nfunction RequestContext.respond_base(self, response,
isfinal)\n local jsonstr = json.encode(response, { indent = false
})\n local buf = buffer.new(5 + #jsonstr)\n buf:set_int32_be(0,
self.rid)\n if isfinal then\n buf:set_uint8(4, 1)\n else\n
buf:set_uint8(4, 0)\n end\n buf:set_string(5, jsonstr)\n
if not self.quiet then \n raat.log.trace(\"SENT [\" ..
tostring(self.r
[0000071] 0.147 TRACE [server] new script with name=raat.dat:protocol.lua module=protocol
[0000072] 0.169 TRACE [session] [192.168.0.14:33763] pre-loading lua module protocol
[0000073] 0.175 TRACE [server] [192.168.0.14:33763] GOT[LL] [4]
{"request":"load_script","sha256":"foo","script":"local base =
require(\"base\")\nlocal protocol = require(\"protocol\")\nlocal json
= require(\"dkjson\")\n\nlocal roon = { }\n\nlocal clock_sock\nlocal
audio_sock\n\nlocal clock_endpoint\nlocal audio_endpoint\nlocal
controls_subscriptions = { }\nlocal transport_subscriptions = {
}\n\nlocal IDLE = \"IDLE\"\nlocal SETUP = \"SETUP\"\nlocal
BUFFERING = \"BUFFERING\"\nlocal READY = \"READY\"\nlocal PLAYING =
\"PLAYING\"\nlocal STOPPED = \"STOPPED\"\n\nlocal
CLOCK_SYNC_ITERATIONS = 5\n\n-- the current playback info\n-- { \n--
stream = stream\n-- token = opaque\n--
setup_cx = request context\n-- stream_cx =
request context\n-- stream_dropouts = nsamples\n-- format
= { ... }\n-- state = IDLE | SETUP |
BUFFERING | PLAYING | STOPPED | READY\n-- nak_port =
number\n-- stream_id
[0000074] 0.176 TRACE [server] new script with name=raat.dat:roon.lua module=(null)
[0000075] 0.177 TRACE [session] [192.168.0.14:33763] executing lua script
[0000076] 0.184 TRACE [server] [192.168.0.14:33763] SENT[LL] [1] {"status": "Success"}
[0000077] 0.184 TRACE [server] [192.168.0.14:33763] SENT[LL] [2] {"status": "Success"}
[0000078] 0.184 TRACE [server] [192.168.0.14:33763] SENT[LL] [3] {"status": "Success"}
[0000079] 0.195 WARNING [lua@0xe683c] [192.168.0.14:33763] failed set recv buffer size: nil
[0000080] 0.195 TRACE [lua@0xe683c] [192.168.0.14:33763] [roon] clock socket listening on udp 0.0.0.0:59453
[0000081] 0.195 TRACE [lua@0xe683c] [192.168.0.14:33763] [roon] audio socket listening on udp 0.0.0.0:40738
[0000082] 0.195 TRACE [lua@0xe683c] [192.168.0.14:33763] [roon]
output info {"alsa_device": {"id": "SPDIF", "mixername": "", "name":
"Integrated SPDIF", "longname": "Integrated SPDIF", "components":
"SPDIF", "driver": "Integrated_SPDI"}}
[0000083] 0.195 TRACE [lua@0xe683c] [192.168.0.14:33763] [roon]
volume info {"supports_dsd": false, "requires_external_persistence":
true}
[0000084] 0.195 TRACE [server] [192.168.0.14:33763] SENT[LL] [4] {"status": "Success"}
[0000085] 0.197 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [2] {"request":"info"}
[0000086] 0.206 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [2]
{"status":"Success","transport":{"is_supported":false,"info":[]},"source_selection":{"is_supported":false,"info":[]},"output":{"supported_formats":[{"bits_per_sample":16,"channels":1,"sample_rate":44100,"sample_type":"pcm"},{"bits_per_sample":24,"channels":1,"sample_rate":44100,"sample_type":"pcm"},{"bits_per_sample":16,"channels":1,"sample_rate":48000,"sample_type":"pcm"},{"bits_per_sample":24,"channels":1,"sample_rate":48000,"sample_type":"pcm"},{"bits_per_sample":16,"channels":1,"sample_rate":88200,"sample_type":"pcm"},{"bits_per_sample":24,"channels":1,"sample_rate":88200,"sample_type":"pcm"},{"bits_per_sample":16,"channels":1,"sample_rate":96000,"sample_type":"pcm"},{"bits_per_sample":24,"channels":1,"sample_rate":96000,"sample_type":"pcm"},{"bits_per_sample":16,"channels":1,"sample_rate":176400,"sample_type":"pcm"},{"bits_per_sample":24,"channels":1,"sample_rate":176400,"sample_type":"pcm"},{"bits_per_sample":16,"channels":1,"sample_rate":192000,"sample_type
[0000087] 0.209 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [3] {"request":"subscribe_transport"}
[0000088] 0.210 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [4] {"request":"subscribe_controls"}
[0000089] 0.211 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [4]
{"status":"Success","controls":{"volume":{"step":1.0,"min":-100.0,"value":0,"info":{"requires_external_persistence":true,"supports_dsd":false},"max":0.0,"type":"db","mute":false}},"action":"Changed"}
[0000090] 0.223 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [5] {"request":"update_volume","value":-82}
[0000091] 0.223 TRACE [volume/software] volume => -82
[0000092] 0.224 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [5] {"status":"Success"}
[0000093] 0.224 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [6] {"request":"update_volume","mute":false}
[0000094] 0.225 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [6] {"status":"Success"}
[0000095] 0.225 TRACE [lua@0xe683c] [192.168.0.14:33763] got output
message {"signal_path": [{"is_passthrough": false, "type":
"digital_volume", "gain": -82.0, "is_muted": false, "quality": "high"},
{"quality": "lossless", "type": "output", "method": "digital"}]}
[0000096] 0.226 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [4]
{"status":"Success","controls":{"volume":{"step":1.0,"min":-100.0,"value":-82,"info":{"requires_external_persistence":true,"supports_dsd":false},"max":0.0,"type":"db","mute":false}},"action":"Changed"}
[0000097] 4.464 TRACE [server] [192.168.0.13:27110] accepted connection
[0000098] 4.470 TRACE [session] [192.168.0.13:27110] starting
[0000099] 4.470 TRACE [session] [192.168.0.13:27110] [internal] executing lua script
[0000100] 4.475 TRACE [session] [192.168.0.13:27110] [internal] executing lua script
[0000101] 4.476 TRACE [session] [192.168.0.13:27110] created
[0000102] 4.516 TRACE [server] [192.168.0.13:27110] read: eof
[0000103] 4.516 TRACE [server] [192.168.0.13:27110] destroying client
[0000104] 4.516 TRACE [session] [192.168.0.13:27110] destroying session
[0000105] 4.516 DEBUG [session] [192.168.0.13:27110] sending async_stop stop cmd
[0000106] 4.517 DEBUG [session] [192.168.0.13:27110] in async_stop stop callback
[0000107] 4.517 DEBUG [session] [192.168.0.13:27110] joining thread
[0000108] 4.517 DEBUG [session] [192.168.0.13:27110] closing loop
[0000109] 5.985 DEBUG [discovery] broadcast op is complete
[0000110] 79.799 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [7]
{"request":"setup","format":{"sample_type":"pcm","sample_rate":96000,"bits_per_sample":24,"channels":2}}
[0000111] 79.799 TRACE alsa output setup: format is pcm 96000/24/2
[0000112] 79.799 TRACE opening [hw:0,0] 96000/24/2
[0000113] 79.801 TRACE prefer larger samples = 1
[0000114] 79.802 TRACE [ALSA] [hw:0,0] using hw pcmformat S24_LE bitspersample 24
[0000115] 79.802 TRACE [ALSA] [hw:0,0] Requesting 9600 frames/period
[0000116] 79.802 TRACE [ALSA] [hw:0,0] Initialized with 4 periods with 8192 frames/period
[0000117] 79.804 TRACE [volume/software] init bitspersample=24
[0000118] 79.804 WARNING sched_setscheduler failed: Operation not permitted
[0000119] 79.804 TRACE samples per buf 8192 ns per buf 85333333 samplerate 96000
[0000120] 79.804 TRACE 8192 samples per buf, 49152 bytes per buf, 65536 bytes per hwbuf
[0000121] 79.804 TRACE [lua@0xe683c] [192.168.0.14:33763] got
output message {"signal_path": [{"is_passthrough": false, "type":
"digital_volume", "gain": -82.0, "is_muted": false, "quality": "high"},
{"quality": "lossless", "type": "output", "method": "digital"}]}
[0000122] 79.804 TRACE [output/alsa] [hw:0,0] waiting for device to be ready
[0000123] 79.804 TRACE [output/alsa] [hw:0,0] device is ready
[0000124] 79.809 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [7]
{"status":"OutputMessage","message":{"signal_path":[{"gain":-82.0,"is_passthrough":false,"quality":"high","type":"digital_volume","is_muted":false},{"method":"digital","type":"output","quality":"lossless"}]}}
[0000125] 79.809 TRACE [lua@0xe683c] [192.168.0.14:33763] got
output message {"signal_path": [{"is_passthrough": false, "type":
"digital_volume", "gain": -82.0, "is_muted": false, "quality": "high"},
{"quality": "lossless", "type": "output", "method": "digital"}]}
[0000126] 79.814 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [7]
{"status":"OutputMessage","message":{"signal_path":[{"gain":-82.0,"is_passthrough":false,"quality":"high","type":"digital_volume","is_muted":false},{"method":"digital","type":"output","quality":"lossless"}]}}
[0000127] 79.827 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [7] {"status":"Success","clock_port":59453,"audio_port":40738}
[0000128] 79.890 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [8]
{"request":"stream","stream_id":1950630812,"first_seq":0,"nak_port":65048}
[0000129] 79.893 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Buffering"}
[0000130] 85.373 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [9] {"request":"start","time":5788236500,"stream_sample":0}
[0000131] 85.378 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Playing"}
[0000132] 85.379 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [9] {"status":"Success"}
[0000133] 85.457 TRACE starting playback: now (5802666666ns) +
ns_per_buf(8568822555787793749ns) = 5887999999ns > 5788236500ns
streamsample=0
[0000134] 85.457 WARNING dropout of 8192 samples at 1385 [2]
[0000135] 85.518 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000136] 85.542 WARNING dropout of 8192 samples at 9577 [2]
[0000137] 85.619 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000138] 85.627 WARNING dropout of 8192 samples at 17769 [2]
[0000139] 85.712 WARNING dropout of 8192 samples at 25961 [2]
[0000140] 85.720 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000141] 85.798 WARNING dropout of 8192 samples at 34153 [2]
[0000142] 85.822 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000143] 85.883 WARNING dropout of 8192 samples at 42345 [2]
[0000144] 85.923 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000145] 85.968 WARNING dropout of 8192 samples at 50537 [2]
[0000146] 86.024 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000147] 86.054 WARNING dropout of 8192 samples at 58729 [2]
[0000148] 86.125 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000149] 86.139 WARNING dropout of 8192 samples at 66921 [2]
[0000150] 86.224 WARNING dropout of 8192 samples at 75113 [2]
[0000151] 86.226 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000152] 86.310 WARNING dropout of 8192 samples at 83305 [2]
[0000153] 86.328 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000154] 86.396 WARNING dropout of 8192 samples at 91497 [2]
[0000155] 86.430 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000156] 86.480 WARNING dropout of 8192 samples at 99689 [2]
[0000157] 86.532 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000158] 86.566 WARNING dropout of 8192 samples at 107881 [2]
[0000159] 86.633 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000160] 86.651 WARNING dropout of 8192 samples at 116073 [2]
[0000161] 86.735 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000162] 86.737 WARNING dropout of 8192 samples at 124265 [2]
[0000163] 86.822 WARNING dropout of 8192 samples at 132457 [2]
[0000164] 86.837 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000165] 86.907 WARNING dropout of 8192 samples at 140649 [2]
[0000166] 86.938 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000167] 86.993 WARNING dropout of 8192 samples at 148841 [2]
[0000168] 87.040 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000169] 87.078 WARNING dropout of 8192 samples at 157033 [2]
[0000170] 87.142 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000171] 87.163 WARNING dropout of 8192 samples at 165225 [2]
[0000172] 87.244 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000173] 87.248 WARNING dropout of 8192 samples at 173417 [2]
[0000174] 87.334 WARNING dropout of 8192 samples at 181609 [2]
[0000175] 87.346 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000176] 87.419 WARNING dropout of 8192 samples at 189801 [2]
[0000177] 87.446 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000178] 87.504 WARNING dropout of 8192 samples at 197993 [2]
[0000179] 87.549 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000180] 87.590 WARNING dropout of 8192 samples at 206185 [2]
[0000181] 87.651 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000182] 87.675 WARNING dropout of 8192 samples at 214377 [2]
[0000183] 87.752 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000184] 87.760 WARNING dropout of 8192 samples at 222569 [2]
[0000185] 87.846 WARNING dropout of 8192 samples at 230761 [2]
[0000186] 87.852 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000187] 87.931 WARNING dropout of 8192 samples at 238953 [2]
[0000188] 87.954 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000189] 88.016 WARNING dropout of 8192 samples at 247145 [2]
[0000190] 88.055 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000191] 88.102 WARNING dropout of 8192 samples at 255337 [2]
[0000192] 88.157 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000193] 88.187 WARNING dropout of 8192 samples at 263529 [2]
[0000194] 88.259 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000195] 88.272 WARNING dropout of 8192 samples at 271721 [2]
[0000196] 88.358 WARNING dropout of 8192 samples at 279913 [2]
[0000197] 88.360 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":16384}
[0000198] 88.443 WARNING dropout of 8192 samples at 288105 [2]
[0000199] 88.461 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Dropout","samples":8192}
[0000200] 88.466 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [10] {"request":"end_stream"}
[0000201] 88.467 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [8] {"status":"Ended"}
[0000202] 88.469 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [10] {"status":"Success"}
[0000203] 107.026 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [11]
{"request":"stream","stream_id":1950630813,"first_seq":724,"nak_port":65048}
[0000204] 107.027 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Buffering"}
[0000205] 112.038 TRACE [lua@0xe683c] [192.168.0.14:33763] GOT [12] {"request":"start","time":32495515967,"stream_sample":0}
[0000206] 112.040 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Playing"}
[0000207] 112.041 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [12] {"status":"Success"}
[0000208] 112.080 TRACE starting playback: now (32426666666ns) +
ns_per_buf(85333333ns) = 32511999999ns > 32495515967ns streamsample=0
[0000209] 112.081 WARNING dropout of 1583 samples at 0 [2]
[0000210] 112.147 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":1583}
[0000211] 112.165 WARNING dropout of 8192 samples at 1583 [2]
[0000212] 112.249 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000213] 112.250 WARNING dropout of 8192 samples at 9775 [2]
[0000214] 112.336 WARNING dropout of 8192 samples at 17967 [2]
[0000215] 112.350 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":16384}
[0000216] 112.421 WARNING dropout of 8192 samples at 26159 [2]
[0000217] 112.451 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000218] 112.507 WARNING dropout of 8192 samples at 34351 [2]
[0000219] 112.553 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000220] 112.592 WARNING dropout of 8192 samples at 42543 [2]
[0000221] 112.654 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000222] 112.677 WARNING dropout of 8192 samples at 50735 [2]
[0000223] 112.755 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000224] 112.762 WARNING dropout of 8192 samples at 58927 [2]
[0000225] 112.848 WARNING dropout of 8192 samples at 67119 [2]
[0000226] 112.857 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":16384}
[0000227] 112.933 WARNING dropout of 8192 samples at 75311 [2]
[0000228] 112.959 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000229] 113.018 WARNING dropout of 8192 samples at 83503 [2]
[0000230] 113.061 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000231] 113.104 WARNING dropout of 8192 samples at 91695 [2]
[0000232] 113.162 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000233] 113.189 WARNING dropout of 8192 samples at 99887 [2]
[0000234] 113.264 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":8192}
[0000235] 113.275 WARNING dropout of 8192 samples at 108079 [2]
[0000236] 113.360 WARNING dropout of 8192 samples at 116271 [2]
[0000237] 113.365 TRACE [lua@0xe683c] [192.168.0.14:33763] SENT [11] {"status":"Dropout","samples":16384}