[Libva] vaPutSurface taking too long
Ratin
ratin3 at gmail.com
Tue Jun 16 16:21:56 PDT 2015
Hi Haihao, NP, With VA_INTEL_DEBUG=2, putsurface takes much less time. Is
there anything we could do to further trace it?
Thanks
Ratin
2015-06-16 16:20:10.583 Delta(usec): 307| Surface : 67108864, Re-ordered
opaque: 20854
|2015-06-16 16:20:10.583 Delta(usec): 40| DrawHorizBand: Surface 67108864
in use , - rendering..
|2015-06-16 16:20:10.583 Delta(usec): 46| Releasing surface: 67108868, we
havent rendred it! exiting..
|2015-06-16 16:20:10.583 Delta(usec): 80| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.584 Delta(usec): 27| Calling va putsurface for suface
ID: 67108869
|2015-06-16 16:20:10.586 Delta(usec): 2221| putsurface done for surface ID:
67108869 with PTS: 20604, diff from last: 42
|2015-06-16 16:20:10.603 Delta(usec): 16917| Allocating surface 67108865
|2015-06-16 16:20:10.603 Delta(usec): 239| Surface : 67108865, Re-ordered
opaque: 21021
|2015-06-16 16:20:10.603 Delta(usec): 61| DrawHorizBand: Surface 67108865
in use , - rendering..
|2015-06-16 16:20:10.603 Delta(usec): 29| Releasing surface: 67108866, we
havent rendred it! exiting..
|2015-06-16 16:20:10.603 Delta(usec): 98| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.603 Delta(usec): 22| Calling va putsurface for suface
ID: 67108867
|2015-06-16 16:20:10.603 Delta(usec): 335| putsurface done for surface ID:
67108867 with PTS: 20646, diff from last: 42
|2015-06-16 16:20:10.622 Delta(usec): 18985| Allocating surface 67108871
|2015-06-16 16:20:10.623 Delta(usec): 204| Surface : 67108871, Re-ordered
opaque: 20938
|2015-06-16 16:20:10.623 Delta(usec): 41| DrawHorizBand: Surface 67108871
in use , - rendering..
|2015-06-16 16:20:10.623 Delta(usec): 28| Releasing surface: 67108872, we
havent rendred it! exiting..
|2015-06-16 16:20:10.623 Delta(usec): 113| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.623 Delta(usec): 25| Calling va putsurface for suface
ID: 67108874
|2015-06-16 16:20:10.623 Delta(usec): 272| putsurface done for surface ID:
67108874 with PTS: 20687, diff from last: 41
|2015-06-16 16:20:10.643 Delta(usec): 20181| Allocating surface 67108875
|2015-06-16 16:20:10.643 Delta(usec): 203| Surface : 67108875, Re-ordered
opaque: 20896
|2015-06-16 16:20:10.644 Delta(usec): 39| DrawHorizBand: Surface 67108875
in use , - rendering..
|2015-06-16 16:20:10.644 Delta(usec): 105| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.644 Delta(usec): 24| Calling va putsurface for suface
ID: 67108868
|2015-06-16 16:20:10.644 Delta(usec): 255| putsurface done for surface ID:
67108868 with PTS: 20729, diff from last: 42
|2015-06-16 16:20:10.663 Delta(usec): 18782| Allocating surface 67108876
|2015-06-16 16:20:10.663 Delta(usec): 199| Surface : 67108876, Re-ordered
opaque: 20979
|2015-06-16 16:20:10.663 Delta(usec): 38| DrawHorizBand: Surface 67108876
in use , - rendering..
|2015-06-16 16:20:10.663 Delta(usec): 28| Releasing surface: 67108875, we
havent rendred it! exiting..
|2015-06-16 16:20:10.663 Delta(usec): 108| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.663 Delta(usec): 24| Calling va putsurface for suface
ID: 67108866
|2015-06-16 16:20:10.663 Delta(usec): 274| putsurface done for surface ID:
67108866 with PTS: 20771, diff from last: 42
|2015-06-16 16:20:10.683 Delta(usec): 19800| Allocating surface 67108878
|2015-06-16 16:20:10.683 Delta(usec): 210| Surface : 67108878, Re-ordered
opaque: 21188
|2015-06-16 16:20:10.683 Delta(usec): 39| DrawHorizBand: Surface 67108878
in use , - rendering..
|2015-06-16 16:20:10.684 Delta(usec): 106| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.684 Delta(usec): 27| Calling va putsurface for suface
ID: 67108872
|2015-06-16 16:20:10.684 Delta(usec): 267| putsurface done for surface ID:
67108872 with PTS: 20812, diff from last: 41
|2015-06-16 16:20:10.704 Delta(usec): 19768| Allocating surface 67108877
|2015-06-16 16:20:10.704 Delta(usec): 197| Surface : 67108877, Re-ordered
opaque: 21104
|2015-06-16 16:20:10.704 Delta(usec): 38| DrawHorizBand: Surface 67108877
in use , - rendering..
|2015-06-16 16:20:10.704 Delta(usec): 28| Releasing surface: 67108876, we
havent rendred it! exiting..
|2015-06-16 16:20:10.704 Delta(usec): 97| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.704 Delta(usec): 25| Calling va putsurface for suface
ID: 67108864
|2015-06-16 16:20:10.704 Delta(usec): 279| putsurface done for surface ID:
67108864 with PTS: 20854, diff from last: 42
|2015-06-16 16:20:10.723 Delta(usec): 18654| Allocating surface 67108873
|2015-06-16 16:20:10.723 Delta(usec): 200| Surface : 67108873, Re-ordered
opaque: 21063
|2015-06-16 16:20:10.723 Delta(usec): 39| DrawHorizBand: Surface 67108873
in use , - rendering..
|2015-06-16 16:20:10.723 Delta(usec): 105| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.723 Delta(usec): 26| Calling va putsurface for suface
ID: 67108875
|2015-06-16 16:20:10.724 Delta(usec): 271| putsurface done for surface ID:
67108875 with PTS: 20896, diff from last: 42
|2015-06-16 16:20:10.743 Delta(usec): 19686| Allocating surface 67108870
|2015-06-16 16:20:10.743 Delta(usec): 198| Surface : 67108870, Re-ordered
opaque: 21146
|2015-06-16 16:20:10.743 Delta(usec): 38| DrawHorizBand: Surface 67108870
in use , - rendering..
|2015-06-16 16:20:10.743 Delta(usec): 26| Releasing surface: 67108873, we
havent rendred it! exiting..
|2015-06-16 16:20:10.744 Delta(usec): 114| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.744 Delta(usec): 26| Calling va putsurface for suface
ID: 67108871
|2015-06-16 16:20:10.744 Delta(usec): 251| putsurface done for surface ID:
67108871 with PTS: 20938, diff from last: 42
|2015-06-16 16:20:10.764 Delta(usec): 19811| Allocating surface 67108869
|2015-06-16 16:20:10.764 Delta(usec): 215| Surface : 67108869, Re-ordered
opaque: 21355
|2015-06-16 16:20:10.764 Delta(usec): 38| DrawHorizBand: Surface 67108869
in use , - rendering..
|2015-06-16 16:20:10.764 Delta(usec): 104| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.764 Delta(usec): 27| Calling va putsurface for suface
ID: 67108876
|2015-06-16 16:20:10.764 Delta(usec): 270| putsurface done for surface ID:
67108876 with PTS: 20979, diff from last: 41
|2015-06-16 16:20:10.784 Delta(usec): 19718| Allocating surface 67108867
|2015-06-16 16:20:10.784 Delta(usec): 205| Surface : 67108867, Re-ordered
opaque: 21271
|2015-06-16 16:20:10.784 Delta(usec): 38| DrawHorizBand: Surface 67108867
in use , - rendering..
|2015-06-16 16:20:10.784 Delta(usec): 27| Releasing surface: 67108870, we
havent rendred it! exiting..
|2015-06-16 16:20:10.784 Delta(usec): 99| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.784 Delta(usec): 25| Calling va putsurface for suface
ID: 67108865
|2015-06-16 16:20:10.785 Delta(usec): 288| putsurface done for surface ID:
67108865 with PTS: 21021, diff from last: 42
|2015-06-16 16:20:10.803 Delta(usec): 18604| Allocating surface 67108874
|2015-06-16 16:20:10.804 Delta(usec): 204| Surface : 67108874, Re-ordered
opaque: 21230
|2015-06-16 16:20:10.804 Delta(usec): 38| DrawHorizBand: Surface 67108874
in use , - rendering..
|2015-06-16 16:20:10.804 Delta(usec): 104| Renderable pic count: 7,
pictureList size: 15
|2015-06-16 16:20:10.804 Delta(usec): 26| Calling va putsurface for suface
ID: 67108873
|2015-06-16 16:20:10.804 Delta(usec): 256| putsurface done for surface ID:
67108873 with PTS: 21063, diff from last: 42
|2015-06-16 16:20:10.824 Delta(usec): 19710| Allocating surface 67108868
On Thu, Jun 11, 2015 at 5:36 PM, Xiang, Haihao <haihao.xiang at intel.com>
wrote:
>
> Hi Ratin,
>
> Sorry for my mistake, the right setting should be 'VA_INTEL_DEBUG=2'.
> You will see a black window after exporting VA_INTEL_DEBUG=2,
> vaPutSurface() won't send the drawable to X for displaying with this
> setting. I wonder which step takes long time in your case.
>
> Thanks
> Haihao
>
>
> > hi Haihao, Thanks for your reply, i made everything in debug mode and
> > set the environment flag (I ssh to the target box, set DISPLAY to the
> > native display (:0) and then on bash prompt, export VA_INTEL_DEBUG=1
> > ) but nothing additional gets printed.
> > When you said "You will see nothing on the window after setting
> > VA_INTEL_DEBUG=1", did you mean on the native window, I should not see
> > any frames rendering and instead I should see something else? Sorry,
> > I am a bit confused.
>
> > Regards,
> >
> >
> > Ratin
> >
> >
> > On Thu, Jun 4, 2015 at 6:07 PM, Xiang, Haihao <haihao.xiang at intel.com>
> > wrote:
> >
> > Maybe it is caused by the display server. You can give a try
> > with
> > setting VA_INTEL_DEBUG=1 in your environment. You will see
> > nothing on
> > the window after setting VA_INTEL_DEBUG=1.
> >
> > Thanks
> > Haihao
> >
> >
> > > I am integrating vaapi with ffmpeg on a Intel Nuc D54250WYK
> > running
> > > ubuntu 14.04.2 LTS with lightDM as the window manager,
> > display
> > > connected via mini HDMI-> regular HDMI to a 1080 P monitor.
> > I am
> > > calling vaPutSurface on a surface and it appears that it
> > takes roughly
> > > abt 30 msec to finish. I was wondering if anybody have an
> > idea why
> > > this would be the case. The surface is allocated, decoded
> > and then
> > > vaPutSurface is called for it. Note the delta in lines like
> > >
> > > "|2015-06-03 17:29:13.210 Delta(usec): 131| Calling va
> > putsurface for
> > > suface ID: 67108864
> > > |2015-06-03 17:29:13.242 Delta(usec): 31561| putsurface done
> > for
> > > surface ID: 67108864
> > > "
> > >
> > >
> > > took 31 msec.
> > >
> > > status = vaPutSurface( pVAAPICNTX->vaDisplay,
> > > vs->id,
> > > pVAAPICNTX->voWindow,
> > > 0, 0,
> > pVAAPICNTX->vid_width,
> > > pVAAPICNTX->vid_height,
> > > 0, 0, pVAAPICNTX->voWidth,
> > > pVAAPICNTX->voHeight,
> > > NULL, 0,
> > > VA_FRAME_PICTURE);
> > >
> > >
> > >
> > > window creation is pretty straight forward:
> > > m_winAttr.background_pixel = XBlackPixel(m_display,
> > > m_visinfo->screen);
> > > win.window = XCreateWindow(m_display, m_rootWindow, rect.x,
> > rect.y,
> > > rect.width, rect.height, 0, m_visinfo->depth, InputOutput,
> > > m_visinfo->visual, CWBackPixel | CWBorderPixel | CWColormap
> > |
> > > CWEventMask | CWOverrideRedirect, &m_winAttr);
> > >
> > > XAllocNamedColor(m_display, m_winAttr.colormap,"black",
> > &color, &rgb);
> > > XSetWindowBackground(m_display, win.window, color.pixel);
> > >
> > > I would like to get some feedback.
> > >
> > >
> > > Thanks
> > >
> > >
> > > Ratin
> > >
> > >
> > > |2015-06-03 17:29:13.209 Delta(usec): 31652| putsurface done
> > for
> > > surface ID: 67108883
> > > |2015-06-03 17:29:13.210 Delta(usec): 1311| Allocating
> > surface
> > > 67108870
> > > |2015-06-03 17:29:13.210 Delta(usec): 266| DrawHorizBand:
> > Surface
> > > 67108870 in use , - rendering..
> > > |2015-06-03 17:29:13.210 Delta(usec): 73| Releasing surface:
> > 67108868,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.210 Delta(usec): 131| Calling va
> > putsurface for
> > > suface ID: 67108864
> > > |2015-06-03 17:29:13.242 Delta(usec): 31561| putsurface done
> > for
> > > surface ID: 67108864
> > > |2015-06-03 17:29:13.243 Delta(usec): 1284| Releasing
> > surface:
> > > 67108868, we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.243 Delta(usec): 66| Allocating surface
> > 67108871
> > > |2015-06-03 17:29:13.244 Delta(usec): 235| DrawHorizBand:
> > Surface
> > > 67108871 in use , - rendering..
> > > |2015-06-03 17:29:13.244 Delta(usec): 160| Calling va
> > putsurface for
> > > suface ID: 67108867
> > > |2015-06-03 17:29:13.275 Delta(usec): 31568| putsurface done
> > for
> > > surface ID: 67108867
> > > |2015-06-03 17:29:13.277 Delta(usec): 1284| Allocating
> > surface
> > > 67108872
> > > |2015-06-03 17:29:13.277 Delta(usec): 267| DrawHorizBand:
> > Surface
> > > 67108872 in use , - rendering..
> > > |2015-06-03 17:29:13.277 Delta(usec): 71| Releasing surface:
> > 67108871,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.277 Delta(usec): 132| Calling va
> > putsurface for
> > > suface ID: 67108866
> > > |2015-06-03 17:29:13.309 Delta(usec): 31595| putsurface done
> > for
> > > surface ID: 67108866
> > > |2015-06-03 17:29:13.310 Delta(usec): 1289| Allocating
> > surface
> > > 67108873
> > > |2015-06-03 17:29:13.310 Delta(usec): 254| DrawHorizBand:
> > Surface
> > > 67108873 in use , - rendering..
> > > |2015-06-03 17:29:13.310 Delta(usec): 153| Calling va
> > putsurface for
> > > suface ID: 67108868
> > > |2015-06-03 17:29:13.342 Delta(usec): 31456| putsurface done
> > for
> > > surface ID: 67108868
> > > |2015-06-03 17:29:13.343 Delta(usec): 1247| Allocating
> > surface
> > > 67108874
> > > |2015-06-03 17:29:13.343 Delta(usec): 240| DrawHorizBand:
> > Surface
> > > 67108874 in use , - rendering..
> > > |2015-06-03 17:29:13.343 Delta(usec): 70| Releasing surface:
> > 67108872,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.343 Delta(usec): 129| Calling va
> > putsurface for
> > > suface ID: 67108865
> > > |2015-06-03 17:29:13.375 Delta(usec): 31632| putsurface done
> > for
> > > surface ID: 67108865
> > > |2015-06-03 17:29:13.376 Delta(usec): 1228| Releasing
> > surface:
> > > 67108872, we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.376 Delta(usec): 66| Allocating surface
> > 67108875
> > > |2015-06-03 17:29:13.377 Delta(usec): 247| DrawHorizBand:
> > Surface
> > > 67108875 in use , - rendering..
> > > |2015-06-03 17:29:13.377 Delta(usec): 141| Calling va
> > putsurface for
> > > suface ID: 67108871
> > > |2015-06-03 17:29:13.408 Delta(usec): 31652| putsurface done
> > for
> > > surface ID: 67108871
> > > |2015-06-03 17:29:13.410 Delta(usec): 1234| Allocating
> > surface
> > > 67108876
> > > |2015-06-03 17:29:13.410 Delta(usec): 257| DrawHorizBand:
> > Surface
> > > 67108876 in use , - rendering..
> > > |2015-06-03 17:29:13.410 Delta(usec): 69| Releasing surface:
> > 67108875,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.410 Delta(usec): 127| Calling va
> > putsurface for
> > > suface ID: 67108870
> > > |2015-06-03 17:29:13.442 Delta(usec): 31668| putsurface done
> > for
> > > surface ID: 67108870
> > > |2015-06-03 17:29:13.443 Delta(usec): 1262| Allocating
> > surface
> > > 67108877
> > > |2015-06-03 17:29:13.443 Delta(usec): 236| DrawHorizBand:
> > Surface
> > > 67108877 in use , - rendering..
> > > |2015-06-03 17:29:13.443 Delta(usec): 161| Calling va
> > putsurface for
> > > suface ID: 67108872
> > > |2015-06-03 17:29:13.475 Delta(usec): 31656| putsurface done
> > for
> > > surface ID: 67108872
> > > |2015-06-03 17:29:13.476 Delta(usec): 1248| Allocating
> > surface
> > > 67108878
> > > |2015-06-03 17:29:13.477 Delta(usec): 250| DrawHorizBand:
> > Surface
> > > 67108878 in use , - rendering..
> > > |2015-06-03 17:29:13.477 Delta(usec): 69| Releasing surface:
> > 67108876,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.477 Delta(usec): 128| Calling va
> > putsurface for
> > > suface ID: 67108869
> > > |2015-06-03 17:29:13.508 Delta(usec): 31638| putsurface done
> > for
> > > surface ID: 67108869
> > > |2015-06-03 17:29:13.510 Delta(usec): 1228| Releasing
> > surface:
> > > 67108876, we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.510 Delta(usec): 79| Allocating surface
> > 67108879
> > > |2015-06-03 17:29:13.510 Delta(usec): 250| DrawHorizBand:
> > Surface
> > > 67108879 in use , - rendering..
> > > |2015-06-03 17:29:13.510 Delta(usec): 140| Calling va
> > putsurface for
> > > suface ID: 67108875
> > > |2015-06-03 17:29:13.542 Delta(usec): 31724| putsurface done
> > for
> > > surface ID: 67108875
> > > |2015-06-03 17:29:13.543 Delta(usec): 1239| Allocating
> > surface
> > > 67108880
> > > |2015-06-03 17:29:13.543 Delta(usec): 232| DrawHorizBand:
> > Surface
> > > 67108880 in use , - rendering..
> > > |2015-06-03 17:29:13.543 Delta(usec): 51| Releasing surface:
> > 67108879,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.544 Delta(usec): 106| Calling va
> > putsurface for
> > > suface ID: 67108874
> > > |2015-06-03 17:29:13.575 Delta(usec): 31677| putsurface done
> > for
> > > surface ID: 67108874
> > > |2015-06-03 17:29:13.576 Delta(usec): 1244| Allocating
> > surface
> > > 67108881
> > > |2015-06-03 17:29:13.577 Delta(usec): 232| DrawHorizBand:
> > Surface
> > > 67108881 in use , - rendering..
> > > |2015-06-03 17:29:13.577 Delta(usec): 126| Calling va
> > putsurface for
> > > suface ID: 67108876
> > > |2015-06-03 17:29:13.609 Delta(usec): 31734| putsurface done
> > for
> > > surface ID: 67108876
> > > |2015-06-03 17:29:13.610 Delta(usec): 1211| Allocating
> > surface
> > > 67108882
> > > |2015-06-03 17:29:13.610 Delta(usec): 233| DrawHorizBand:
> > Surface
> > > 67108882 in use , - rendering..
> > > |2015-06-03 17:29:13.610 Delta(usec): 48| Releasing surface:
> > 67108880,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.610 Delta(usec): 104| Calling va
> > putsurface for
> > > suface ID: 67108873
> > > |2015-06-03 17:29:13.642 Delta(usec): 31764| putsurface done
> > for
> > > surface ID: 67108873
> > > |2015-06-03 17:29:13.643 Delta(usec): 1229| Releasing
> > surface:
> > > 67108880, we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.643 Delta(usec): 56| Allocating surface
> > 67108883
> > > |2015-06-03 17:29:13.643 Delta(usec): 205| DrawHorizBand:
> > Surface
> > > 67108883 in use , - rendering..
> > > |2015-06-03 17:29:13.643 Delta(usec): 126| Calling va
> > putsurface for
> > > suface ID: 67108879
> > > |2015-06-03 17:29:13.675 Delta(usec): 31694| putsurface done
> > for
> > > surface ID: 67108879
> > > |2015-06-03 17:29:13.676 Delta(usec): 1234| Allocating
> > surface
> > > 67108864
> > > |2015-06-03 17:29:13.677 Delta(usec): 229| DrawHorizBand:
> > Surface
> > > 67108864 in use , - rendering..
> > > |2015-06-03 17:29:13.677 Delta(usec): 50| Releasing surface:
> > 67108883,
> > > we havent rendred it! exiting..
> > > |2015-06-03 17:29:13.677 Delta(usec): 106| Calling va
> > putsurface for
> > > suface ID: 67108878
> > > |2015-06-03 17:29:13.709 Delta(usec): 31713| putsurface done
> > for
> > > surface ID: 67108878
> > > |2015-06-03 17:29:13.710 Delta(usec): 1243| Allocating
> > surface
> > > 67108867
> > > |2015-06-03 17:29:13.710 Delta(usec): 225| DrawHorizBand:
> > Surface
> > > 67108867 in use , - rendering..
> > > |2015-06-03 17:29:13.710 Delta(usec): 127| Calling va
> > putsurface for
> > > suface ID: 67108880
> > > |2015-06-03 17:29:13.742 Delta(usec): 31744| putsurface done
> > for
> > > surface ID: 67108880
> > > |2015-06-03 17:29:13.743 Delta(usec): 1248| Allocating
> > surface
> > > 67108866
> > > |2015-06-03 17:29:13.743 Delta(usec): 233| DrawHorizBand:
> > Surface
> > > 67108866 in use , - rendering..
> > > |2015-06-03 17:29:13.743 Delta(usec): 50| Releasing surface:
> > 67108864,
> > > we havent rendred i
> > >
> > >
> >
> > > _______________________________________________
> > > Libva mailing list
> > > Libva at lists.freedesktop.org
> > > http://lists.freedesktop.org/mailman/listinfo/libva
> >
> >
> >
> >
>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freedesktop.org/archives/libva/attachments/20150616/121fb6ba/attachment-0001.html>
More information about the Libva
mailing list