[Bug 774654] Flushing can hang if output port queue of pending buffers is empty

Sat Nov 26 23:42:25 UTC 2016

https://bugzilla.gnome.org/show_bug.cgi?id=774654

--- Comment #9 from minfrin at sharp.fm ---
I'm using a Raspberry Pi 3.

I have discovered it is possible to extract logging out of the graphics card
itself, and when I run the omxh264dec directly into omxh264enc I get the
decoder behaving as follows:

pi at towerofpi9:~$ sudo vcdbg log msg 2>&1 | grep decode

// good start, we begin receiving packets to decode

222323.608: video_decode:3:RIL: setup image requirements (544x576(544x576)x7)
222327.784: video_decode:3:RIL: decoding 24140 bytes, 2361053us, flags 30,
(cb:0x3e4e9780)
222327.797: video_decode:3:RIL: asking for more
222327.848: video_decode:3:RIL: decoding 8352 bytes, 2200522us, flags 10,
(cb:0x3e4e979c)
222327.862: video_decode:3:RIL: asking for more
222328.261: video_decode:3:RIL: new image requirements (544x576(544x576)x7)
222331.257: video_decode:3:RIL: decoding 4153 bytes, 2120348us, flags 10,
(cb:0x3e4e97b8)
222331.269: video_decode:3:RIL: asking for more
222334.031: video_decode:3:RIL: decoding 1999 bytes, 2080321us, flags 10,
(cb:0x3e4e97d4)
222334.042: video_decode:3:RIL: asking for more
222380.267: video_decode:3:RIL: decoding 2174 bytes, 2160310us, flags 10,
(cb:0x3e4e97f0)
222380.279: video_decode:3:RIL: asking for more
222403.209: video_decode:3:RIL: decoding 5503 bytes, 2280310us, flags 10,
(cb:0x3e4e980c)
222403.220: video_decode:3:RIL: asking for more
222419.430: video_decode:3:RIL: decoding 2611 bytes, 2240304us, flags 10,
(cb:0x3e4e9828)
222419.441: video_decode:3:RIL: asking for more

// we start getting callbacks at this point

222419.733: video_decode:3:RIL:cb:next_frame_time:2080321000
222419.751: video_decode:3:RIL:cb:discard (cb:0x3e4e97d4), w:1 v:1 f:0 s:0
222547.894: video_decode:3:RIL: decoding 1927 bytes, 2320304us, flags 10,
(cb:0x3e4e9844)
222547.906: video_decode:3:RIL: asking for more
222548.201: video_decode:3:RIL:cb:discard (cb:0x3e4e97b8), w:1 v:1 f:0 s:0
222627.263: video_decode:3:RIL: decoding 15224 bytes, 2680303us, flags 10,
(cb:0x3e4e9860)
222627.275: video_decode:3:RIL: asking for more
222627.589: video_decode:3:RIL:cb:discard (cb:0x3e4e97f0), w:1 v:1 f:0 s:0
222653.226: video_decode:3:RIL: decoding 9048 bytes, 2520303us, flags 10,
(cb:0x3e4e987c)
222653.240: video_decode:3:RIL: asking for more
222653.569: video_decode:3:RIL:cb:discard (cb:0x3e4e979c), w:1 v:1 f:0 s:0
222676.996: video_decode:3:RIL: decoding 4368 bytes, 2440303us, flags 10,
(cb:0x3e4e9898)
222677.009: video_decode:3:RIL: asking for more
222677.308: video_decode:3:RIL:cb:discard (cb:0x3e4e9828), w:1 v:1 f:0 s:0
222691.396: video_decode:3:RIL: decoding 1874 bytes, 2400303us, flags 10,
(cb:0x3e4e98b4)
222691.410: video_decode:3:RIL: asking for more
222691.700: video_decode:3:RIL:cb:discard (cb:0x3e4e980c), w:1 v:1 f:0 s:0
222733.372: video_decode:3:RIL: decoding 2100 bytes, 2480303us, flags 10,
(cb:0x3e4e98d0)
222733.384: video_decode:3:RIL: asking for more
222733.678: video_decode:3:RIL:cb:discard (cb:0x3e4e9844), w:1 v:1 f:0 s:0
222753.796: video_decode:3:RIL: decoding 5020 bytes, 2600303us, flags 10,
(cb:0x3e4e98ec)
222753.810: video_decode:3:RIL: asking for more

// we seem to get actual frames now

222754.149: video_decode:3:RIL:cb:I time:2361053, cb:0x3e4e9780, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
222754.206: video_decode:3:RIL:cb:B time:2400303, cb:0x3e4e98b4, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
222754.226: video_decode:3:RIL:resolution changing
223368.123: video_decode:3:RIL:output dec_frames_full:3e4ea700 out:3e512460
223368.987: video_decode:3:RIL:output done, dec_frames_full:3e4ea774 out:0
223370.926: video_decode:3:RIL:output dec_frames_full:3e4ea774 out:3e5124e0
223371.879: video_decode:3:RIL:output done, dec_frames_full:0 out:0
223376.495: video_decode:3:RIL: decoding 1963 bytes, 2560303us, flags 10,
(cb:0x3e4e9908)
223376.509: video_decode:3:RIL: asking for more
223376.846: video_decode:3:RIL:cb:B time:2440303, cb:0x3e4e9898, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223376.870: video_decode:3:RIL:output dec_frames_full:3e4ea7e8 out:3e512560
223378.386: video_decode:3:RIL:output done, dec_frames_full:0 out:0
223389.831: video_decode:3:RIL: decoding 1911 bytes, 2640303us, flags 10,
(cb:0x3e4e9924)
223389.847: video_decode:3:RIL: asking for more
223390.172: video_decode:3:RIL:cb:B time:2480303, cb:0x3e4e98d0, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223390.197: video_decode:3:RIL:output dec_frames_full:3e4ea85c out:3e5125e0
223391.665: video_decode:3:RIL:output done, dec_frames_full:0 out:0
223397.317: video_decode:3:RIL: decoding 14845 bytes, 3000303us, flags 10,
(cb:0x3e4e9940)
223397.329: video_decode:3:RIL: asking for more
223400.407: video_decode:3:RIL: decoding 8384 bytes, 2840303us, flags 10,
(cb:0x3e4e995c)
223400.423: video_decode:3:RIL: asking for more
223400.833: video_decode:3:RIL:cb:B time:2520303, cb:0x3e4e987c, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223410.292: video_decode:3:RIL: decoding 4390 bytes, 2760303us, flags 10,
(cb:0x3e4e9978)
223410.303: video_decode:3:RIL: asking for more
223410.637: video_decode:3:RIL:cb:B time:2560303, cb:0x3e4e9908, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223413.963: video_decode:3:RIL: decoding 1950 bytes, 2720303us, flags 10,
(cb:0x3e4e9994)
223413.977: video_decode:3:RIL: asking for more
223414.291: video_decode:3:RIL:cb:B time:2600303, cb:0x3e4e98ec, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223417.884: video_decode:3:RIL: decoding 2287 bytes, 2800303us, flags 10,
(cb:0x3e4e99b0)
223417.896: video_decode:3:RIL: asking for more
223418.219: video_decode:3:RIL:cb:B time:2640303, cb:0x3e4e9924, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223421.297: video_decode:3:RIL: decoding 4460 bytes, 2920303us, flags 10,
(cb:0x3e4e99cc)
223421.311: video_decode:3:RIL: asking for more
223421.636: video_decode:3:RIL:cb:P time:2680303, cb:0x3e4e9860, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223421.689: video_decode:3:RIL:cb:B time:2720303, cb:0x3e4e9994, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0
223425.006: video_decode:3:RIL: decoding 2044 bytes, 2880303us, flags 10,
(cb:0x3e4e99e8)
223425.020: video_decode:3:RIL: asking for more
223425.338: video_decode:3:RIL:cb:B time:2760303, cb:0x3e4e9978, ar:64/33,
crop:0x0 544x576, interval:40000000, interlace:1,1,0

// suddenly, no more callbacks

223428.601: video_decode:3:RIL: decoding 2043 bytes, 2960303us, flags 10,
(cb:0x3e4e9a04)
223428.613: video_decode:3:RIL: asking for more
223433.073: video_decode:3:RIL: decoding 14092 bytes, 3320303us, flags 10,
(cb:0x3e4e9a20)
223433.085: video_decode:3:RIL: asking for more
223443.807: video_decode:3:RIL: decoding 8278 bytes, 3160303us, flags 10,
(cb:0x3e4e9a3c)
223443.821: video_decode:3:RIL: asking for more
223447.946: video_decode:3:RIL: decoding 5403 bytes, 3080303us, flags 10,
(cb:0x3e4e9a58)
223447.959: video_decode:3:RIL: asking for more
223451.931: video_decode:3:RIL: decoding 2508 bytes, 3040303us, flags 10,
(cb:0x3e4e9a74)
223451.944: video_decode:3:RIL: asking for more
223456.181: video_decode:3:RIL: decoding 2662 bytes, 3120303us, flags 10,
(cb:0x3e4e9a90)
223456.194: video_decode:3:RIL: asking for more
223460.990: video_decode:3:RIL: decoding 5032 bytes, 3240303us, flags 10,
(cb:0x3e4e9aac)
223461.003: video_decode:3:RIL: asking for more
223469.775: video_decode:3:RIL: decoding 2365 bytes, 3200303us, flags 10,
(cb:0x3e4e9ac8)
223469.788: video_decode:3:RIL: asking for more
223475.646: video_decode:3:RIL: decoding 2221 bytes, 3280303us, flags 10,
(cb:0x3e4e9ae4)
223475.659: video_decode:3:RIL: asking for more
223530.151: video_decode:3:RIL: decoding 25602 bytes, 3640303us, flags 30,
(cb:0x3e4e9b00)
223530.165: video_decode:3:RIL: asking for more
223569.608: video_decode:3:RIL: decoding 7733 bytes, 3480303us, flags 10,
(cb:0x3e4e9b1c)
223569.621: video_decode:3:RIL: asking for more
223576.654: video_decode:3:RIL: decoding 5181 bytes, 3400303us, flags 10,
(cb:0x3e4e9b38)
223576.666: video_decode:3:RIL: asking for more
223588.723: video_decode:3:RIL: decoding 2259 bytes, 3360303us, flags 10,
(cb:0x3e4e9b54)
223588.735: video_decode:3:RIL: asking for more
223621.823: video_decode:3:RIL: decoding 2313 bytes, 3440303us, flags 10,
(cb:0x3e4e9b70)
223621.837: video_decode:3:RIL: asking for more
223636.732: video_decode:3:RIL: decoding 4955 bytes, 3560303us, flags 10,
(cb:0x3e4e9b8c)
223636.746: video_decode:3:RIL: asking for more
223657.505: video_decode:3:RIL: decoding 2369 bytes, 3520303us, flags 10,
(cb:0x3e4e9ba8)
223657.518: video_decode:3:RIL: asking for more
223740.549: video_decode:3:RIL: decoding 2257 bytes, 3600303us, flags 10,
(cb:0x3e4e9bc4)
223740.562: video_decode:3:RIL: asking for more
223796.533: video_decode:3:RIL: decoding 13347 bytes, 3960303us, flags 10,
(cb:0x3e4e9be0)
223796.546: video_decode:3:RIL: asking for more
223835.193: video_decode:3:RIL: decoding 8569 bytes, 3800303us, flags 10,
(cb:0x3e4e9bfc)
223835.207: video_decode:3:RIL: asking for more
223844.099: video_decode:3:RIL: decoding 4585 bytes, 3720303us, flags 10,
(cb:0x3e4e9c18)
223844.114: video_decode:3:RIL: asking for more
223852.417: video_decode:3:RIL: decoding 2397 bytes, 3680303us, flags 10,
(cb:0x3e4e9c34)
223852.430: video_decode:3:RIL: asking for more
223891.909: video_decode:3:RIL: decoding 2312 bytes, 3760303us, flags 10,
(cb:0x3e4e9c50)
223891.922: video_decode:3:RIL: asking for more
223907.790: video_decode:3:RIL: decoding 5108 bytes, 3880303us, flags 10,
(cb:0x3e4e9c6c)
223907.804: video_decode:3:RIL: asking for more
223923.713: video_decode:3:RIL: decoding 2616 bytes, 3840303us, flags 10,
(cb:0x3e4e9c88)
223923.726: video_decode:3:RIL: asking for more
224011.923: video_decode:3:RIL: decoding 2479 bytes, 3920303us, flags 10,
(cb:0x3e4e9ca4)
224011.936: video_decode:3:RIL: asking for more
224075.808: video_decode:3:RIL: decoding 13723 bytes, 4280303us, flags 10,
(cb:0x3e4e9cc0)
224075.822: video_decode:3:RIL: asking for more
224119.127: video_decode:3:RIL: decoding 9421 bytes, 4120303us, flags 10,
(cb:0x3e4e9cdc)
224119.139: video_decode:3:RIL: asking for more
224134.403: video_decode:3:RIL: decoding 5754 bytes, 4040303us, flags 10,
(cb:0x3e4e9cf8)
224134.416: video_decode:3:RIL: asking for more
224148.553: video_decode:3:RIL: decoding 3066 bytes, 4000303us, flags 10,
(cb:0x3e4e9d14)
224148.564: video_decode:3:RIL: asking for more
224188.054: video_decode:3:RIL: decoding 2654 bytes, 4080303us, flags 10,
(cb:0x3e4e9d30)
224188.066: video_decode:3:RIL: asking for more
224197.547: video_decode:3:RIL: decoding 5316 bytes, 4200303us, flags 10,
(cb:0x3e4e9d4c)
224197.566: video_decode:3:RIL: asking for more
224214.089: video_decode:3:RIL: decoding 2524 bytes, 4160303us, flags 10,
(cb:0x3e4e9d68)
224214.106: video_decode:3:RIL: asking for more
224301.559: video_decode:3:RIL: decoding 2719 bytes, 4240303us, flags 10,
(cb:0x3e4e9d84)
224301.578: video_decode:3:RIL: asking for more
224358.659: video_decode:3:RIL: decoding 13821 bytes, 4600303us, flags 10,
(cb:0x3e4e9da0)
224358.677: video_decode:3:RIL: asking for more
224390.496: video_decode:3:RIL: decoding 8669 bytes, 4440320us, flags 10,
(cb:0x3e4e9dbc)
224390.517: video_decode:3:RIL: asking for more
224406.641: video_decode:3:RIL: decoding 4800 bytes, 4360326us, flags 10,
(cb:0x3e4e9dd8)
224406.661: video_decode:3:RIL: asking for more
224420.517: video_decode:3:RIL: decoding 2339 bytes, 4320332us, flags 10,
(cb:0x3e4e9df4)
224420.537: video_decode:3:RIL: asking for more
224453.355: video_decode:3:RIL: decoding 2394 bytes, 4400332us, flags 10,
(cb:0x3e4e9e10)
224453.374: video_decode:3:RIL: asking for more
224468.612: video_decode:3:RIL: decoding 5020 bytes, 4520337us, flags 10,
(cb:0x3e4e9e2c)
224468.632: video_decode:3:RIL: asking for more
224486.511: video_decode:3:RIL: decoding 2448 bytes, 4480343us, flags 10,
(cb:0x3e4e9e48)
224486.530: video_decode:3:RIL: asking for more
224653.833: video_decode:3:RIL: decoding 2513 bytes, 4560343us, flags 10,
(cb:0x3e4e9e64)
224653.853: video_decode:3:RIL: asking for more
224713.624: video_decode:3:RIL: decoding 27329 bytes, 4920348us, flags 30,
(cb:0x3e4e9e80)
224713.642: video_decode:3:RIL: asking for more
224766.332: video_decode:3:RIL: decoding 9225 bytes, 4760359us, flags 10,
(cb:0x3e4e9e9c)
224766.348: video_decode:3:RIL: asking for more
224779.945: video_decode:3:RIL: decoding 5881 bytes, 4680359us, flags 10,
(cb:0x3e4e9eb8)
224779.961: video_decode:3:RIL: asking for more
224785.573: video_decode:3:RIL: decoding 2547 bytes, 4640359us, flags 10,
(cb:0x3e4e9ed4)
224785.591: video_decode:3:RIL: asking for more
224814.986: video_decode:3:RIL: decoding 2622 bytes, 4720359us, flags 10,
(cb:0x3e4e9ef0)
224815.003: video_decode:3:RIL: asking for more
224837.437: video_decode:3:RIL: decoding 5590 bytes, 4840359us, flags 10,
(cb:0x3e4e9f0c)
224837.454: video_decode:3:RIL: asking for more
224852.394: video_decode:3:RIL: decoding 2636 bytes, 4800359us, flags 10,
(cb:0x3e4e9f28)
224852.411: video_decode:3:RIL: asking for more
224941.373: video_decode:3:RIL: decoding 2374 bytes, 4880358us, flags 10,
(cb:0x3e4e9f44)
224941.389: video_decode:3:RIL: asking for more
224990.446: video_decode:3:RIL: decoding 13314 bytes, 5240358us, flags 10,
(cb:0x3e4e9f60)
224990.462: video_decode:3:RIL: asking for more
225023.058: video_decode:3:RIL: decoding 8752 bytes, 5080358us, flags 10,
(cb:0x3e4e9f7c)
225023.078: video_decode:3:RIL: asking for more
225048.351: video_decode:3:RIL: decoding 5105 bytes, 5000358us, flags 10,
(cb:0x3e4e9f98)
225048.371: video_decode:3:RIL: asking for more
225058.508: video_decode:3:RIL: decoding 2481 bytes, 4960358us, flags 10,
(cb:0x3e4e9fb4)
225058.528: video_decode:3:RIL: asking for more
225085.374: video_decode:3:RIL: decoding 2484 bytes, 5040358us, flags 10,
(cb:0x3e4e9fd0)
225085.394: video_decode:3:RIL: asking for more
225107.343: video_decode:3:RIL: decoding 4644 bytes, 5160358us, flags 10,
(cb:0x3e4e9fec)
225107.362: video_decode:3:RIL: asking for more
225117.303: video_decode:3:RIL: decoding 2673 bytes, 5120358us, flags 10,
(cb:0x3e4ea008)
225117.321: video_decode:3:RIL: asking for more
225197.247: video_decode:3:RIL: decoding 2127 bytes, 5200358us, flags 10,
(cb:0x3e4ea024)
225197.266: video_decode:3:RIL: asking for more
225253.310: video_decode:3:RIL: decoding 12836 bytes, 5560358us, flags 10,
(cb:0x3e4ea040)
225253.330: video_decode:3:RIL: asking for more
225311.350: video_decode:3:RIL: decoding 8612 bytes, 5400358us, flags 10,
(cb:0x3e4ea05c)
225311.368: video_decode:3:RIL: asking for more
225318.159: video_decode:3:RIL: decoding 5067 bytes, 5320358us, flags 10,
(cb:0x3e4ea078)
225318.178: video_decode:3:RIL: asking for more
225326.041: video_decode:3:RIL: decoding 2710 bytes, 5280358us, flags 10,
(cb:0x3e4ea094)
225326.058: video_decode:3:RIL: asking for more
225358.392: video_decode:3:RIL: decoding 2410 bytes, 5360358us, flags 10,
(cb:0x3e4ea0b0)
225358.410: video_decode:3:RIL: asking for more
225372.811: video_decode:3:RIL: decoding 5574 bytes, 5480358us, flags 10,
(cb:0x3e4ea0cc)
225372.828: video_decode:3:RIL: asking for more
225383.517: video_decode:3:RIL: decoding 2583 bytes, 5440358us, flags 10,
(cb:0x3e4ea0e8)
225383.534: video_decode:3:RIL: asking for more
225465.921: video_decode:3:RIL: decoding 2316 bytes, 5520358us, flags 10,
(cb:0x3e4ea104)
225465.933: video_decode:3:RIL: asking for more
225523.481: video_decode:3:RIL: decoding 12573 bytes, 5880358us, flags 10,
(cb:0x3e4ea120)
225523.494: video_decode:3:RIL: asking for more
225562.546: video_decode:3:RIL: decoding 8271 bytes, 5720358us, flags 10,
(cb:0x3e4ea13c)
225562.562: video_decode:3:RIL: asking for more
225566.221: video_decode:3:RIL: decoding 4546 bytes, 5640358us, flags 10,
(cb:0x3e4ea158)
225566.234: video_decode:3:RIL: asking for more
225580.588: video_decode:3:RIL: decoding 2503 bytes, 5600358us, flags 10,
(cb:0x3e4ea174)
225580.600: video_decode:3:RIL: asking for more
225623.347: video_decode:3:RIL: decoding 2626 bytes, 5680358us, flags 10,
(cb:0x3e4ea190)
225623.360: video_decode:3:RIL: asking for more
225635.841: video_decode:3:RIL: decoding 5393 bytes, 5800358us, flags 10,
(cb:0x3e4ea1ac)
225635.854: video_decode:3:RIL: asking for more
225666.334: video_decode:3:RIL: decoding 2575 bytes, 5760358us, flags 10,
(cb:0x3e4ea1c8)
225666.348: video_decode:3:RIL: asking for more
225724.574: video_decode:3:RIL: decoding 2730 bytes, 5840358us, flags 10,
(cb:0x3e4ea1e4)
225724.587: video_decode:3:RIL: asking for more
225772.234: video_decode:3:RIL: decoding 11491 bytes, 6160358us, flags 10,
(cb:0x3e4e97d4)
225772.248: video_decode:3:RIL: asking for more
225814.333: video_decode:3:RIL: decoding 7261 bytes, 6040356us, flags 10,
(cb:0x3e4e97b8)
225814.344: video_decode:3:RIL: asking for more
225827.537: video_decode:3:RIL: decoding 5143 bytes, 5960353us, flags 10,
(cb:0x3e4e97f0)
225827.548: video_decode:3:RIL: asking for more
225844.679: video_decode:3:RIL: decoding 2857 bytes, 5920352us, flags 10,
(cb:0x3e4e979c)
225844.689: video_decode:3:RIL: asking for more
225891.662: video_decode:3:RIL: decoding 2496 bytes, 6000352us, flags 10,
(cb:0x3e4e9828)
225891.674: video_decode:3:RIL: asking for more
225895.068: video_decode:3:RIL: decoding 4114 bytes, 6120350us, flags 10,
(cb:0x3e4e980c)
225895.080: video_decode:3:RIL: asking for more
226057.897: video_decode:3:RIL: decoding 2355 bytes, 6080349us, flags 10,
(cb:0x3e4e9844)
226057.908: video_decode:3:RIL: asking for more
226099.888: video_decode:3:RIL: decoding 26365 bytes, 6280349us, flags 30,
(cb:0x3e4e98b4)
226099.900: video_decode:3:RIL: asking for more
226114.744: video_decode:3:RIL: decoding 5685 bytes, 6240342us, flags 10,
(cb:0x3e4e9898)
226114.758: video_decode:3:RIL: asking for more
226185.112: video_decode:3:RIL: decoding 2670 bytes, 6200340us, flags 10,
(cb:0x3e4e9780)
226185.125: video_decode:3:RIL: asking for more
226242.586: video_decode:3:RIL: decoding 10679 bytes, 6600340us, flags 10,
(cb:0x3e4e98d0)
226242.600: video_decode:3:RIL: asking for more
226275.839: video_decode:3:RIL: decoding 8748 bytes, 6440337us, flags 10,
(cb:0x3e4e987c)
226275.851: video_decode:3:RIL: asking for more
226291.469: video_decode:3:RIL: decoding 5643 bytes, 6360335us, flags 10,
(cb:0x3e4e9908)
226291.484: video_decode:3:RIL: asking for more
226314.483: video_decode:3:RIL: waiting for a cb structure

// and we're stuck

-- 
You are receiving this mail because:
You are the QA Contact for the bug.
You are the assignee for the bug.