ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

eglCreateImage fails when playing video in Chromium

Tue Jul 21, 2020 2:49 pm

I'm trying to get V4L2 decode working in a custom build of Chromium. I have successfully run tests on the Pi using the Video Decode Accelerator (VDA), which I am now trying to use in-browser.

The decoder successfully initialises, requests buffers, streams, and handles the initial resolution change. However, when trying to composite the resulting frames, EGL fails:

Code: Select all

[978:978:0721/103103.710606:VERBOSE3:generic_v4l2_device.cc(223)] CreateEGLImage()
Attempt to import unsupported winsys offset 1024
[978:978:0721/103103.713144:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[978:978:0721/103103.714585:VERBOSE1:generic_v4l2_device.cc(259)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[978:978:0721/103103.715054:ERROR:v4l2_video_decode_accelerator.cc(498)] could not create EGLImageKHR, index=0 texture_id=85
[978:978:0721/103103.715330:VERBOSE1:v4l2_video_decode_accelerator.cc(500)] CreateEGLImageFor(): Setting error state:4
[978:1117:0721/103103.716531:VERBOSE1:v4l2_video_decode_accelerator.cc(2047)] NotifyError()
I initially thought the problem might be with memory allocation, seen as eglCreateImage returns EGL_BAD_ALLOC; but I then noticed that, before this, something reports "Attempt to import unsupported winsys offset 1024".

The only sources I can find for this error are a couple of commits in the Mesa repo (0c1dd9de, 873b092e). The code here appears to produce this error if using the T-tiled format with an offset > 0.

The test program, video_decode_accelerator_tests, allocates buffers with minigbm. The T-tiled format is not possible in minigbm, and it will throw an error if asked to use it. I cannot see that the tests use EGL.

The VDA does not appear to use minigbm in-browser (or throws an error before it reaches minigbm), so I wonder if it is using the T-tiled format when calling eglCreateImageKHR.

So my questions are: Is this definitely an issue with the T-tiled format, or have I misinterpreted the error? Would this work if I created an EGL image with a linear format? If so, how can I do this?

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Tue Jul 21, 2020 3:56 pm

You diagnosis of where the error is being thrown looks correct.
Are you on a Pi0-3, or Pi4, just so we know if we're looking at vc4 or v3d? Whilst very similar they obviously take different code paths.

(I do so love the Chromium code where they've adopted the Android stance of the only formats ever existing being NV12 and YV12)

My guess is that it's not properly configuring the EGL image for NV12 (cf V4L2_PIX_FMT_NV12M).
NV12 from V4L2's perspective is a single plane and has implicit definitions of where the chroma planes are with relation to the start of the buffer. NV12M has multiple (2) planes, and independent dmabuf file descriptors for them.

The loop at https://chromium.googlesource.com/chrom ... ice.cc#243 looks dubious as if num_planes is going to be 1, so it is going to only add a single plane (ie luma) before calling eglCreateImageKHR. EGL doesn't impose the same restrictions on layout as V4L2's NV12, so it will complain that there is no chroma plane.
I could be totally wrong on this, but it wouldn't hurt to add a little bit of logging to confirm exactly which call Chromium is objecting to (actually we know it is that funciton as the logging does state "generic_v4l2_device.cc(259)").
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Tue Jul 21, 2020 4:41 pm

Okay, it's making sense so far! I'm using a Pi 4, which means V3D?

I have, in fact, forced the decoder to use NV12 instead of YV12, as this was the only format that worked with the VDA tests. I believe this is irrelevant, though, as V4L2 sees YV12 as a single plane too? I get the same error regardless.

I had actually added some extra logging to prove it is the eglCreateImageKHR function that is unhappy, I just omitted it above.

Code: Select all

VLOGF(1) << "ewanr: Begin eglCreateImageKHR";
EGLImageKHR egl_image = eglCreateImageKHR(
    egl_display, EGL_NO_CONTEXT, EGL_LINUX_DMA_BUF_EXT, NULL, &attrs[0]);
VLOGF(1) << "ewanr: End eglCreateImageKHR";
if (egl_image == EGL_NO_IMAGE_KHR) {
  VLOGF(1) << "Failed creating EGL image: " << ui::GetLastEGLErrorString();
  return egl_image;
}

With the extra debugging, you get:

Code: Select all

[13061:13061:0721/151132.051703:VERBOSE3:generic_v4l2_device.cc(223)] CreateEGLImage():
[13061:13061:0721/151132.052337:VERBOSE1:generic_v4l2_device.cc(254)] CreateEGLImage(): ewanr: Begin eglCreateImageKHR
Attempt to import unsupported winsys offset 1024
[13061:13061:0721/151132.053412:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[13061:13061:0721/151132.056403:VERBOSE1:generic_v4l2_device.cc(257)] CreateEGLImage(): ewanr: End eglCreateImageKHR
[13061:13061:0721/151132.056697:VERBOSE1:generic_v4l2_device.cc(259)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[13061:13061:0721/151132.056975:ERROR:v4l2_video_decode_accelerator.cc(498)] could not create EGLImageKHR, index=2 texture_id=13
[13061:13061:0721/151132.057441:VERBOSE1:v4l2_video_decode_accelerator.cc(500)] CreateEGLImageFor(): Setting error state:4

I don't know if you recall the V4L2 application I had created previously. For this, I was using RGB565, and could not get DRM to accept YV12 or NV12 frames. I believe this was because I couldn't work out the correct offsets and strides to use. I had tried to port over a function I'd found on your GitHub profile, but it didn't work. I had, however, managed to add an option for RGB565, which is much simpler of course.

Code: Select all

switch (pix_fmt->pixelformat) {
    // 3 plane YUV formats
    case GBM_FORMAT_YUV420:
    case GBM_FORMAT_YVU420:
        fd_mod_data->strides[0] = pix_fmt->plane_fmt[0].bytesperline;
        fd_mod_data->strides[1] = fd_mod_data->strides[2] = fd_mod_data->strides[0] / 2;

        fd_mod_data->offsets[0] = 0;
        fd_mod_data->offsets[1] = fd_mod_data->strides[0] * pix_fmt->height;
        fd_mod_data->offsets[2] = fd_mod_data->offsets[1] + fd_mod_data->strides[1] * pix_fmt->height / 2;

        *depth = 12;

        fd_mod_data->fds[0] = fd_mod_data->fds[1] = fd_mod_data->fds[2] = dmabufs[0];
        break;
    // 2 plane YUV formats
    case GBM_FORMAT_NV12:
    case GBM_FORMAT_NV21:
        fd_mod_data->strides[0] = fd_mod_data->strides[1] = pix_fmt->plane_fmt[0].bytesperline;

        fd_mod_data->offsets[0] = 0;
        fd_mod_data->offsets[1] = fd_mod_data->strides[0] * pix_fmt->height;

        *depth = 12;

        fd_mod_data->fds[0] = fd_mod_data->fds[1] = dmabufs[0];
        break;
    // Packed-pixel RGB formats
    case GBM_FORMAT_RGB565:
        fd_mod_data->strides[0] = pix_fmt->plane_fmt[0].bytesperline;

        fd_mod_data->offsets[0] = 0;

        *depth = 16;

        fd_mod_data->fds[0] = dmabufs[0];
        break;
    default:
        fprintfourcc(stderr, "Cannot read pixel format: %c%c%c%c\n",
                        pix_fmt->pixelformat);
        exit(EXIT_FAILURE);
}

I wonder if I could manually set the offsets and strides like above, instead of the for loop Chromium have included. If so, can you see anything wrong with my calculations above for YV12 and NV12?

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Tue Jul 21, 2020 5:47 pm

The x11 branch on https://github.com/6by9/drm_mmal/blob/x11/drm_mmal.c should do the right thing in setting up pitches, offsets, and fds, for the different formats.
https://github.com/6by9/drm_mmal/blob/x ... mal.c#L479 then stuffs it into the attribs struct for eglCreateImageKHR.

NV12M and NV21M would give you 2 independent planes from V4L2. YV12 and YU12 will give you 3. I suspect those are the only formats that Chromium have actually tested with.

FFmpeg was the same - we had to add support for any single planar formats other than NV12 https://github.com/FFmpeg/FFmpeg/commit ... a841c2f8b3
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Tue Jul 21, 2020 5:52 pm

And I think you probably want to amend the current code at https://chromium.googlesource.com/chrom ... ice.cc#243 to something like

Code: Select all

attrs.push_back(EGL_DMA_BUF_PLANE0_FD_EXT);
attrs.push_back(handle.planes[0].fd.get());
attrs.push_back(EGL_DMA_BUF_PLANE0_OFFSET_EXT);
attrs.push_back(handle.planes[0].offset);
attrs.push_back(EGL_DMA_BUF_PLANE0_PITCH_EXT);
attrs.push_back(handle.planes[0].stride);

if (num_planes == 1) { 
  switch(fourcc.ToV4L2PixFmt()) {
  case NV12:
  case NV21:
    //Fix up the chroma plane
    break;
  case YU12:
  case YV12:
    //Fix up the 2 chroma planes
    break;
} else {
  for (size_t plane = 1; plane < num_planes; ++plane) {
    attrs.push_back(EGL_DMA_BUF_PLANE0_FD_EXT + plane * 3);
    attrs.push_back(handle.planes[plane].fd.get());
    attrs.push_back(EGL_DMA_BUF_PLANE0_OFFSET_EXT + plane * 3);
    attrs.push_back(handle.planes[plane].offset);
    attrs.push_back(EGL_DMA_BUF_PLANE0_PITCH_EXT + plane * 3);
    attrs.push_back(handle.planes[plane].stride);
  }
}
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 11:18 am

I was looking into implementing something like your suggestion, but in doing so have found that there isn't just 1 plane, in fact.
As mentioned here, the num_planes variable is actually the number of components in the format, not the number of V4L2 planes. So Chromium does actually set up 2/3 planes before calling eglCreateImageKHR.

Here's a log of the for loop using NV12 buffers:

Code: Select all

[7896:7896:0722/120136.640099:VERBOSE1:generic_v4l2_device.cc(223)] CreateEGLImage():
[7896:7896:0722/120136.640852:VERBOSE1:generic_v4l2_device.cc(243)] Num planes: 2
[7896:7896:0722/120136.641368:VERBOSE1:generic_v4l2_device.cc(244)] Width: 32
[7896:7896:0722/120136.643201:VERBOSE1:generic_v4l2_device.cc(245)] Height: 32
[7896:7896:0722/120136.643650:VERBOSE1:generic_v4l2_device.cc(248)] Plane 0 handle: 109
[7896:7896:0722/120136.644269:VERBOSE1:generic_v4l2_device.cc(249)] Plane 0 offset: 0
[7896:7896:0722/120136.644759:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 stride: 32
[7896:7896:0722/120136.645126:VERBOSE1:generic_v4l2_device.cc(248)] Plane 1 handle: 110
[7896:7896:0722/120136.645429:VERBOSE1:generic_v4l2_device.cc(249)] Plane 1 offset: 1024
[7896:7896:0722/120136.646019:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 stride: 32
Attempt to import unsupported winsys offset 1024
[7896:7896:0722/120136.646748:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[7896:7896:0722/120136.647311:VERBOSE1:generic_v4l2_device.cc(303)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[7896:7896:0722/120136.647885:ERROR:v4l2_video_decode_accelerator.cc(498)] could not create EGLImageKHR, index=0 texture_id=69
[7896:7896:0722/120136.648290:VERBOSE1:v4l2_video_decode_accelerator.cc(500)] CreateEGLImageFor(): Setting error state:4

And again using YV12 buffers:

Code: Select all

[8185:8185:0722/120405.938663:VERBOSE1:generic_v4l2_device.cc(223)] CreateEGLImage():
[8185:8185:0722/120405.938878:VERBOSE1:generic_v4l2_device.cc(243)] Num planes: 3
[8185:8185:0722/120405.939017:VERBOSE1:generic_v4l2_device.cc(244)] Width: 32
[8185:8185:0722/120405.939211:VERBOSE1:generic_v4l2_device.cc(245)] Height: 32
[8185:8185:0722/120405.939695:VERBOSE1:generic_v4l2_device.cc(248)] Plane 0 handle: 102
[8185:8185:0722/120405.939852:VERBOSE1:generic_v4l2_device.cc(249)] Plane 0 offset: 0
[8185:8185:0722/120405.939990:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 stride: 32
[8185:8185:0722/120405.940125:VERBOSE1:generic_v4l2_device.cc(248)] Plane 1 handle: 103
[8185:8185:0722/120405.940260:VERBOSE1:generic_v4l2_device.cc(249)] Plane 1 offset: 1024
[8185:8185:0722/120405.940396:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 stride: 16
[8185:8185:0722/120405.940531:VERBOSE1:generic_v4l2_device.cc(248)] Plane 2 handle: 104
[8185:8185:0722/120405.940665:VERBOSE1:generic_v4l2_device.cc(249)] Plane 2 offset: 1280
[8185:8185:0722/120405.940809:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 stride: 16
Attempt to import unsupported winsys offset 1024
[8185:8185:0722/120405.941215:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[8185:8185:0722/120405.941393:VERBOSE1:generic_v4l2_device.cc(303)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[8185:8185:0722/120405.941541:ERROR:v4l2_video_decode_accelerator.cc(498)] could not create EGLImageKHR, index=0 texture_id=110
[8185:8185:0722/120405.941697:VERBOSE1:v4l2_video_decode_accelerator.cc(500)] CreateEGLImageFor(): Setting error state:4

I suppose this means that Chromium has already determined the offsets/strides in our single V4L2 plane, as we were going to do? They seem to match the calculations you suggested above.

The thing I find a little strange is that the width is the default 32x32, instead of the actual size 1920x1080 (I'm using a 1080p copy of Big Buck Bunny). The dynamic resolution change has occurred, so the correct resolution should have been extracted from the stream, yet:

Code: Select all

[8479:8590:0722/121050.260426:VERBOSE2:v4l2_video_decode_accelerator.cc(1966)] StartResolutionChange(): Initiate resolution change
[8479:8590:0722/121050.261000:VERBOSE2:v4l2_video_decode_accelerator.cc(1923)] StopOutputStream():
[8479:8590:0722/121050.261283:VERBOSE2:v4l2_video_decode_accelerator.cc(2441)] DestroyOutputBuffers():
[8479:8590:0722/121050.261590:VERBOSE2:v4l2_video_decode_accelerator.cc(1995)] FinishResolutionChange():
[8479:8590:0722/121050.262002:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (CAPTURE_MPLANE) ewanr: VIDIOC_G_FMT, { type: 9, fmt { pix: { width: 32, height: 32, pixelformat: YV12 }, pix_mp: { width: 32, height: 32, pixelformat: YV12 } } }
[8479:8590:0722/121050.262412:VERBOSE1:v4l2_video_decode_accelerator.cc(2166)] GetVisibleSize(): visible size is empty
[8479:8590:0722/121050.262678:VERBOSE2:v4l2_video_decode_accelerator.cc(2141)] CreateBuffersForFormat(): new resolution: 32x32, visible size: 32x32, decoder output planes count: , EGLImage size: 32x32, EGLImage plane count: 1

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 1:21 pm

It sounds like we need to find what is creating the "gfx::NativePixmapHandle handle" that is passed into GenericV4L2Device::CreateEGLImage.

I don't have a Chromium source tree cloned at present to search, and I suspect it may take a while to pull down.
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 2:10 pm

OK, cloned, but nothing obvious.

Your comment about G_FMT returning 32x32 does seem odd. The default resolution is 640x480, so something appears to have reset it to 32x32 (which is the minimum that the codec component will allow).

You can add bcm2835_codec.debug=5 to /boot/cmdline.txt (no carriage returns please) to increase the amount of logging that the codec driver spits out. You can also set /sys/class/video4linux/video10/dev_debug to enable V4L2 framework logging. It's a bitmask of V4L2_DEV_DEBUG_* values defined in https://elixir.bootlin.com/linux/latest ... ctl.h#L596
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 2:40 pm

It appears Chromium has set the input H.264 buffers to 0x0px.

Code: Select all

[  154.757992] bcm2835-codec bcm2835-codec: Setting format for type 10, wxh: 0x0, fmt: H264, size 524288
[  154.758000] bcm2835-codec bcm2835-codec: Calulated bpl as 0, size 524288
[  154.759607] bcm2835-codec bcm2835-codec: Setting format for type 9, wxh: 32x32, fmt: YV12, size 1536
[  154.759620] bcm2835-codec bcm2835-codec: Calulated bpl as 32, size 1536

I can see this in the Chromium output in fact:

Code: Select all

[844:972:0722/151602.719036:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (OUTPUT_MPLANE) ewanr: VIDIOC_G_FMT, { type: 10, fmt { pix: { width: 0, height: 0, pixelformat: H264 }, pix_mp: { width: 0, height: 0, pixelformat: H264 } } }

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:02 pm

Don't get confused between codec input and output, and V4L2 OUTPUT and CAPTURE.

V4L2 started with CAPTURE devices being webcams and TV tuners, so things that generated data.
It also had hardware that could add overlays, or OUTPUT, but they consume data.
That's where the names for the values in enum v4l2_buf_type come from (https://elixir.bootlin.com/linux/latest ... ev2.h#L141)

Apply the same logic to memory-to-memory devices and an OUTPUT queue is the input to the codec (it consumes data), and the CAPTURE queue is the output of the codec (it generates data).
The OUTPUT queue taking encoded H264 data doesn't care about resolution as it is described in the codec header bytes. Those header bytes should set up the CAPTURE queue parameters.

The interesting part would be the return value from the G_FMT ioctl in V4L2VideoDecodeAccelerator::FinishResolutionChange as it is completing the dynamic resolution change sequence. That wants the V4L2 framework logging. Does the codec really return 32x32 still? I hope not.

Can you throw a complete log from Chromium somewhere so I can see the rough sequence of events that we're seeing? My brain is going through the daft race conditions of the codec input side being fed the header bytes and producing the resolution changed event before the init code has set the output (CAPTURE) format/resolution, so the result of the res changed is effectively discarded.
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:12 pm

Yes, that's what I meant sorry. The H.264 output buffers (type 10) are set to 0x0, the YV12 capture buffers (type 9) are then set to 32x32. I may have made this more confusing by saying "Chromium output" when I meant the log!

While 32x32 is not the default, like you say, it is the minimum. So certainly interesting to find where it gets this number. I'll take a closer look at the resolution change.

Here's a complete log. You'll have to forgive the mess/incompleteness. I cannot get debug builds to run on the Pi, so am having to add extra debugging to release builds myself. Hopefully this gives you a good idea still.

Code: Select all

[1:1:0722/155250.679877:INFO:hugepage_text.cc(93)] no transparent hugepage support, fall back to small page: Invalid argument (22)
[1401:1401:0722/155250.679894:INFO:hugepage_text.cc(93)] no transparent hugepage support, fall back to small page: Invalid argument (22)
[1398:1398:0722/155250.735181:WARNING:chrome_browser_main_chromeos.cc(492)] Running as stub user with profile dir: test-user
[1398:1398:0722/155250.792361:VERBOSE1:webrtc_event_log_manager.cc(93)] WebRTC remote-bound event logging enabled.
[1425:1425:0722/155250.850883:WARNING:gbm_surface_factory.cc(115)] Platform device extensions not found.
MINIGBM: INIT!
[1398:1398:0722/155250.900487:VERBOSE1:pulse_util.cc(232)] Failed to connect to the context.  Error: Connection refused
[1398:1398:0722/155250.900619:WARNING:audio_manager_linux.cc(59)] Falling back to ALSA for audio output. PulseAudio is not available or could not be initialized.
[1398:1417:0722/155250.989019:ERROR:arc_property_util.cc(294)] arc-build-properties is not found
[1398:1417:0722/155250.989355:ERROR:arc_property_util.cc(268)] Failed to read /usr/share/arc/properties/build.prop: No such file or directory (2)
[1398:1417:0722/155250.989531:ERROR:arc_property_util.cc(373)] Failed to expand /usr/share/arc/properties/build.prop
[1425:1425:0722/155251.198028:ERROR:gbm_surface_factory.cc(181)] Couldn't create Gbm Device at /dev/dri/renderD128
[1425:1425:0722/155251.207060:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found H.264 (0x34363248)
[1425:1425:0722/155251.207267:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found Motion-JPEG (0x47504a4d)
[1425:1425:0722/155251.207469:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found VP8 (0x30385056)
[1425:1425:0722/155251.207663:VERBOSE1:v4l2_device.cc(2003)] EnumerateSupportedPixelformats(): ewanr: VIDIOC_ENUM_FMT
[1425:1425:0722/155251.208582:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found H.264 (0x34363248)
[1425:1425:0722/155251.208754:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found Motion-JPEG (0x47504a4d)
[1425:1425:0722/155251.209121:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found VP8 (0x30385056)
[1425:1425:0722/155251.209425:VERBOSE1:v4l2_device.cc(2003)] EnumerateSupportedPixelformats(): ewanr: VIDIOC_ENUM_FMT
[1425:1425:0722/155251.209666:VERBOSE1:v4l2_device.cc(1973)] GetSupportedResolution(): ewanr: VIDIOC_ENUM_FRAMESIZES
[1425:1425:0722/155251.209936:VERBOSE1:v4l2_device.cc(1973)] GetSupportedResolution(): ewanr: VIDIOC_ENUM_FRAMESIZES
[1425:1425:0722/155251.210244:VERBOSE1:gpu_video_decode_accelerator_factory.cc(136)] ewanr: Queried capabilities...
[1425:1425:0722/155251.211289:VERBOSE2:v4l2_video_encode_accelerator.cc(567)] Destroy():
[1425:1425:0722/155251.211511:VERBOSE1:gpu_video_encode_accelerator_factory.cc(171)] GetSupportedProfiles(): Supported profiles empty, querying again...
[1425:1425:0722/155251.212541:VERBOSE2:v4l2_video_encode_accelerator.cc(567)] Destroy():
[1425:1442:0722/155251.213672:VERBOSE2:v4l2_video_encode_accelerator.cc(925)] DestroyTask():
[1425:1442:0722/155251.214717:VERBOSE1:generic_v4l2_device.cc(117)] SetDevicePollInterrupt(): write() failed: Bad file descriptor (9)
[1425:1442:0722/155251.214999:VERBOSE2:v4l2_video_encode_accelerator.cc(1782)] DestroyInputBuffers():
[1425:1441:0722/155251.212073:VERBOSE2:v4l2_video_encode_accelerator.cc(925)] DestroyTask():
MINIGBM: INIT!
[1425:1441:0722/155251.221449:VERBOSE1:generic_v4l2_device.cc(117)] SetDevicePollInterrupt(): write() failed: Bad file descriptor (9)
[1425:1441:0722/155251.223344:VERBOSE2:v4l2_video_encode_accelerator.cc(1782)] DestroyInputBuffers():
[1425:1441:0722/155251.224358:VERBOSE2:v4l2_video_encode_accelerator.cc(1794)] DestroyOutputBuffers():
[1425:1441:0722/155251.225105:VERBOSE2:v4l2_video_encode_accelerator.cc(195)] ~V4L2VideoEncodeAccelerator():
[1425:1442:0722/155251.216516:VERBOSE2:v4l2_video_encode_accelerator.cc(1794)] DestroyOutputBuffers():
[1425:1442:0722/155251.225974:VERBOSE2:v4l2_video_encode_accelerator.cc(195)] ~V4L2VideoEncodeAccelerator():
[1398:1412:0722/155251.274978:WARNING:braille_controller_brlapi.cc(84)] Couldn't load libbrlapi(libbrlapi.so.0.8: Success
[1398:1398:0722/155251.329670:WARNING:remote_commands_service.cc(173)] Client is not registered.
[1398:1398:0722/155251.347588:WARNING:wallpaper_controller_client.cc(371)] Cannot get wallpaper files id in RemovePolicyWallpaper. This should never happen under normal circumstances.
[1398:1398:0722/155251.368237:INFO:tether_service.cc(418)] Tether state has changed. New state: [BLE is not present on the device], Old state: [TetherService initializing]
sd-device-enumerator: Scan all dirs
sd-device-enumerator: Scanning /sys/bus
sd-device-enumerator: Scanning /sys/class
sd-device-enumerator: Scan all dirs
[1425:1435:0722/155251.524263:ERROR:drm_gpu_display_manager.cc(191)] There is no display with ID 2763301329721600
sd-device-enumerator: Scanning /sys/bus
sd-device-enumerator: Scanning /sys/class
[1398:1398:0722/155251.601587:ERROR:plugin_vm_manager_impl.cc(109)] New session has dispatcher unexpected already running. Perhaps Chrome crashed?
[1425:1435:0722/155251.650389:ERROR:drm_thread_proxy.cc(44)] Unable to initialize GBM for /sys/devices/platform/v3dbus/fec00000.v3d/drm/card0: Permission denied (13)
[1398:1398:0722/155251.657771:ERROR:account_manager_migrator.cc(257)] Could not find a refresh token for the Device Account.
[1398:1398:0722/155251.658775:WARNING:device_sync_impl.cc(465)] DeviceSyncImpl::GetLocalDeviceMetadata() invoked before initialization was complete. Cannot return local device metadata.
[1398:1398:0722/155251.661789:WARNING:drivefs_session.cc(62)] DriveFs mount failed with error: 3
sd-device-enumerator: Scan all dirs
sd-device-enumerator: Scanning /sys/bus
[1398:1398:0722/155251.695513:WARNING:device_sync_impl.cc(479)] DeviceSyncImpl::GetSyncedDevices() invoked before initialization was complete. Cannot return devices.
sd-device-enumerator: Scanning /sys/class
[1398:1398:0722/155251.776647:INFO:android_sms_pairing_state_tracker_impl.cc(72)] No Pairing cookie found
MINIGBM: CREATE! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1438:0722/155252.278342:VERBOSE1:gpu_video_encode_accelerator_factory.cc(171)] GetSupportedProfiles(): Supported profiles empty, querying again...
[1425:1438:0722/155252.285259:VERBOSE2:v4l2_video_encode_accelerator.cc(567)] Destroy():
[1425:1524:0722/155252.299178:VERBOSE2:v4l2_video_encode_accelerator.cc(925)] DestroyTask():
[1425:1524:0722/155252.301002:VERBOSE1:generic_v4l2_device.cc(117)] SetDevicePollInterrupt(): write() failed: Bad file descriptor (9)
[1425:1524:0722/155252.302903:VERBOSE2:v4l2_video_encode_accelerator.cc(1782)] DestroyInputBuffers():
[1425:1524:0722/155252.304334:VERBOSE2:v4l2_video_encode_accelerator.cc(1794)] DestroyOutputBuffers():
[1425:1524:0722/155252.305098:VERBOSE2:v4l2_video_encode_accelerator.cc(195)] ~V4L2VideoEncodeAccelerator():
[1425:1525:0722/155252.309917:VERBOSE1:gpu_mojo_media_client.cc(208)] ewanr: Trying VDA
[1425:1525:0722/155252.313058:VERBOSE1:gpu_video_decode_accelerator_factory.cc(136)] ewanr: Queried capabilities...
[1398:1398:0722/155252.482514:WARNING:CONSOLE(5722)] "Getting volumes", source: chrome-extension://hhaomjibdihmijegdhdafkllkbggdgoj/background/js/background_common_scripts.js (5722)
[1398:1398:0722/155252.508727:WARNING:CONSOLE(5750)] "Initialized all 1 volumes", source: chrome-extension://hhaomjibdihmijegdhdafkllkbggdgoj/background/js/background_common_scripts.js (5750)
[1455:12:0722/155252.570493:VERBOSE1:mojo_video_decoder.cc(122)] ewanr: MojoVideoDecoder
[1455:12:0722/155252.570851:VERBOSE1:mojo_video_decoder.cc(164)] ewanr: Initialize
[1455:12:0722/155252.571584:VERBOSE3:mojo_video_decoder.cc(369)] ewanr: BindRemoteDecoder
MINIGBM: CREATE! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1525:0722/155252.635962:VERBOSE1:gpu_video_decode_accelerator_factory.cc(136)] ewanr: Queried capabilities...
[1425:1425:0722/155252.677580:VERBOSE1:gpu_video_decode_accelerator_factory.cc(162)] CREATING GPU VDA
[1425:1425:0722/155252.678575:VERBOSE1:v4l2_video_decode_accelerator.cc(171)] USING VIDEO DECODE ACCELERATOR
[1425:1425:0722/155252.679603:VERBOSE2:v4l2_video_decode_accelerator.cc(172)] Initialize(): profile: 3, output_mode=0
[1425:1549:0722/155252.680710:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found H.264 (0x34363248)
[1425:1549:0722/155252.681079:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found Motion-JPEG (0x47504a4d)
[1425:1549:0722/155252.681664:VERBOSE3:v4l2_device.cc(1999)] EnumerateSupportedPixelformats(): ewanr: Found VP8 (0x30385056)
[1425:1549:0722/155252.682043:VERBOSE1:v4l2_device.cc(2003)] EnumerateSupportedPixelformats(): ewanr: VIDIOC_ENUM_FMT
[1425:1549:0722/155252.683278:VERBOSE1:v4l2_device.cc(897)] V4L2Queue(): (OUTPUT_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1549:0722/155252.683818:VERBOSE1:v4l2_device.cc(897)] V4L2Queue(): (CAPTURE_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1549:0722/155252.684194:VERBOSE1:v4l2_device.cc(1973)] GetSupportedResolution(): ewanr: VIDIOC_ENUM_FRAMESIZES
[1425:1549:0722/155252.684550:VERBOSE1:v4l2_video_decode_accelerator.cc(2246)] SetupFormats(): ewanr: Found format: YU12
[1425:1549:0722/155252.684898:VERBOSE1:v4l2_video_decode_accelerator.cc(2246)] SetupFormats(): ewanr: Found format: YV12
[1425:1549:0722/155252.685251:VERBOSE1:v4l2_video_decode_accelerator.cc(2250)] SetupFormats(): ewanr: Using format: YV12
[1425:1549:0722/155252.685582:VERBOSE2:v4l2_video_decode_accelerator.cc(2284)] SetupFormats(): Output format=YV12
[1425:1425:0722/155252.685986:VERBOSE2:v4l2_video_decode_accelerator.cc(820)] TryToSetupDecodeOnSeparateThread():
[1425:1549:0722/155252.686701:VERBOSE2:v4l2_video_decode_accelerator.cc(2183)] CreateInputBuffers():
[1425:1549:0722/155252.687090:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (OUTPUT_MPLANE) ewanr: VIDIOC_G_FMT, { type: 10, fmt { pix: { width: 0, height: 0, pixelformat: H264 }, pix_mp: { width: 0, height: 0, pixelformat: H264 } } }
[1425:1549:0722/155252.687465:VERBOSE3:v4l2_device.cc(1042)] AllocateBuffers(): (OUTPUT_MPLANE) ewanr: Requesting 8 buffers.
[1455:12:0722/155252.689175:VERBOSE1:mojo_video_decoder.cc(215)] ewanr: OnInitializeDone: status = 0
[1455:12:0722/155252.689538:VERBOSE3:mojo_video_decoder.cc(349)] ewanr: NeedsBitstreamConversion
[1455:12:0722/155252.690230:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.690596:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=66667 duration=33333 size=1155 is_key_frame=1 encrypted=0}
[1455:12:0722/155252.691020:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.691550:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=100000 duration=33333 size=12283 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.691836:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.692306:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=133333 duration=33333 size=12108 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.692623:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.693093:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=200000 duration=33333 size=15326 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.693419:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.716989:VERBOSE1:v4l2_device.cc(1049)] AllocateBuffers(): (OUTPUT_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1549:0722/155252.718307:VERBOSE3:v4l2_device.cc(1051)] AllocateBuffers(): (OUTPUT_MPLANE) ewanr: queue 10: got 8 buffers.
[1425:1549:0722/155252.719139:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 0), flags: 4000
[1425:1549:0722/155252.720232:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 1 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 524288), flags: 4000
[1425:1549:0722/155252.721431:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 2 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 1048576), flags: 4000
[1425:1549:0722/155252.722745:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 3 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 1572864), flags: 4000
[1425:1549:0722/155252.723874:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 4 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 2097152), flags: 4000
[1425:1549:0722/155252.724932:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 5 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 2621440), flags: 4000
[1425:1549:0722/155252.725860:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 6 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 3145728), flags: 4000
[1425:1549:0722/155252.726943:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 7 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 524288, data_offset: 0, m.mem_offset: 3670016), flags: 4000
MINIGBM: CREATE! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1549:0722/155252.728282:VERBOSE1:v4l2_device.cc(1146)] QueueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_QBUF
[1425:1549:0722/155252.734537:VERBOSE1:v4l2_device.cc(1242)] Streamon(): (OUTPUT_MPLANE) ewanr: VIDIOC_STREAMON
[1425:1549:0722/155252.735132:VERBOSE1:v4l2_device.cc(1187)] DequeueBuffer(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 31, length: 524288, data_offset: 0, m.mem_offset: 0), flags: 4003
[1425:1549:0722/155252.735383:VERBOSE1:v4l2_device.cc(1198)] DequeueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_DQBUF handling error: Resource temporarily unavailable (11)
[1425:1549:0722/155252.735890:VERBOSE1:v4l2_device.cc(1146)] QueueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_QBUF
[1425:1549:0722/155252.737105:VERBOSE1:v4l2_device.cc(1187)] DequeueBuffer(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 31, length: 524288, data_offset: 0, m.mem_offset: 0), flags: 4003
[1425:1549:0722/155252.739253:VERBOSE1:v4l2_device.cc(1198)] DequeueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_DQBUF handling error: Resource temporarily unavailable (11)
[1425:1549:0722/155252.740043:VERBOSE1:v4l2_device.cc(1146)] QueueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_QBUF
[1425:1435:0722/155252.742824:INFO:drm_display.cc(177)] 'Content Protection' property doesn't exist.: Permission denied (13)
[1425:1549:0722/155252.743146:VERBOSE1:v4l2_device.cc(1187)] DequeueBuffer(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 31, length: 524288, data_offset: 0, m.mem_offset: 0), flags: 4003
[1425:1549:0722/155252.756677:VERBOSE1:v4l2_device.cc(1198)] DequeueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_DQBUF handling error: Resource temporarily unavailable (11)
[1455:12:0722/155252.757907:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.758756:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.758123:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (CAPTURE_MPLANE) ewanr: VIDIOC_G_FMT, { type: 9, fmt { pix: { width: 32, height: 32, pixelformat: YV12 }, pix_mp: { width: 32, height: 32, pixelformat: YV12 } } }
[1455:12:0722/155252.759636:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=166667 duration=33333 size=309 is_key_frame=0 encrypted=0}
MINIGBM: CREATE_WITH_MODIFIERS! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1549:0722/155252.760874:VERBOSE1:v4l2_video_decode_accelerator.cc(2168)] GetVisibleSize(): visible size is empty
[1455:12:0722/155252.761296:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.762014:VERBOSE1:v4l2_device.cc(2108)] DequeueEvent(): ewanr: VIDIOC_DQEVENT attempt
[1425:1549:0722/155252.762706:VERBOSE3:v4l2_device.cc(2110)] DequeueEvent(): Failed to dequeue event: No such file or directory (2)
[1425:1549:0722/155252.763094:VERBOSE1:v4l2_device.cc(1187)] DequeueBuffer(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 10, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 31, length: 524288, data_offset: 0, m.mem_offset: 0), flags: 4003
[1425:1549:0722/155252.769609:VERBOSE1:v4l2_device.cc(1198)] DequeueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_DQBUF handling error: Resource temporarily unavailable (11)
[1425:1549:0722/155252.770143:VERBOSE2:v4l2_video_decode_accelerator.cc(1968)] StartResolutionChange(): Initiate resolution change
[1425:1549:0722/155252.770886:VERBOSE2:v4l2_video_decode_accelerator.cc(1925)] StopOutputStream():
[1425:1549:0722/155252.771567:VERBOSE2:v4l2_video_decode_accelerator.cc(2443)] DestroyOutputBuffers():
[1425:1549:0722/155252.772103:VERBOSE2:v4l2_video_decode_accelerator.cc(1997)] FinishResolutionChange():
[1425:1549:0722/155252.772674:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (CAPTURE_MPLANE) ewanr: VIDIOC_G_FMT, { type: 9, fmt { pix: { width: 32, height: 32, pixelformat: YV12 }, pix_mp: { width: 32, height: 32, pixelformat: YV12 } } }
[1425:1549:0722/155252.773065:VERBOSE1:v4l2_video_decode_accelerator.cc(2168)] GetVisibleSize(): visible size is empty
MINIGBM: CREATE_WITH_MODIFIERS! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1549:0722/155252.777081:VERBOSE2:v4l2_video_decode_accelerator.cc(2143)] CreateBuffersForFormat(): new resolution: 32x32, visible size: 32x32, decoder output planes count: , EGLImage size: 32x32, EGLImage plane count: 1
[1425:1549:0722/155252.777498:VERBOSE2:v4l2_video_decode_accelerator.cc(2383)] CreateOutputBuffers():
[1425:1549:0722/155252.777781:VERBOSE1:v4l2_device.cc(2177)] GetCtrl(): ewanr: VIDIOC_G_EXT_CTRLS
[1425:1425:0722/155252.784740:VERBOSE2:v4l2_video_decode_accelerator.cc(358)] AssignPictureBuffers(): buffer_count=6
[1425:1549:0722/155252.785204:VERBOSE2:v4l2_video_decode_accelerator.cc(369)] AssignPictureBuffersTask():
[1425:1549:0722/155252.785570:VERBOSE1:v4l2_device.cc(954)] GetFormat(): (CAPTURE_MPLANE) ewanr: VIDIOC_G_FMT, { type: 9, fmt { pix: { width: 32, height: 32, pixelformat: YV12 }, pix_mp: { width: 32, height: 32, pixelformat: YV12 } } }
[1425:1549:0722/155252.785806:VERBOSE3:v4l2_device.cc(1042)] AllocateBuffers(): (CAPTURE_MPLANE) ewanr: Requesting 6 buffers.
[1425:1549:0722/155252.786419:VERBOSE1:v4l2_device.cc(1049)] AllocateBuffers(): (CAPTURE_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1549:0722/155252.786646:VERBOSE3:v4l2_device.cc(1051)] AllocateBuffers(): (CAPTURE_MPLANE) ewanr: queue 9: got 6 buffers.
[1425:1549:0722/155252.786981:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 0 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073741824), flags: 4000
[1425:1549:0722/155252.787436:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 1 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073745920), flags: 4000
[1425:1549:0722/155252.787788:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 2 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073750016), flags: 4000
[1425:1549:0722/155252.788115:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 3 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073754112), flags: 4000
[1425:1549:0722/155252.788491:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 4 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073758208), flags: 4000
[1425:1549:0722/155252.788869:VERBOSE1:v4l2_device.cc(159)] Query(): ewanr: VIDIOC_QUERYBUF: v4l2_buffer type: 9, memory: 1, index: 5 bytesused: 0, length: 1, m.planes[0](bytesused: 0, length: 1536, data_offset: 0, m.mem_offset: 1073762304), flags: 4000
MINIGBM: CREATE_WITH_MODIFIERS! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[1425:1549:0722/155252.790852:VERBOSE1:v4l2_device.cc(1146)] QueueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_QBUF
[1455:12:0722/155252.791657:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.791885:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.792136:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=233333 duration=33333 size=8657 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.792659:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.794643:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=0
[1425:1425:0722/155252.795213:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1425:1425:0722/155252.795494:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1425:1425:0722/155252.795984:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1425:1425:0722/155252.796201:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1425:1425:0722/155252.796482:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 102
[1425:1425:0722/155252.796803:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1425:1425:0722/155252.797149:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1425:1425:0722/155252.797510:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 107
[1425:1425:0722/155252.797804:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1425:1425:0722/155252.798104:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1425:1425:0722/155252.798389:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 108
[1425:1425:0722/155252.798682:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1425:1425:0722/155252.799074:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
Attempt to import unsupported winsys offset 1024
[1425:1425:0722/155252.799724:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1425:1425:0722/155252.800224:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1425:1425:0722/155252.800657:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=0 texture_id=14
[1425:1425:0722/155252.801020:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1425:1425:0722/155252.801405:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=1
[1425:1425:0722/155252.801807:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1425:1425:0722/155252.802199:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1425:1425:0722/155252.802508:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1425:1425:0722/155252.802801:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1425:1425:0722/155252.803166:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 116
[1425:1425:0722/155252.803611:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1425:1549:0722/155252.804211:VERBOSE1:v4l2_device.cc(1146)] QueueBuffer(): (OUTPUT_MPLANE) ewanr: VIDIOC_QBUF
[1425:1425:0722/155252.804207:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1425:1425:0722/155252.804571:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 117
[1455:12:0722/155252.804992:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.804929:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1455:12:0722/155252.805368:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.805360:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1425:1425:0722/155252.805688:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 118
[1425:1425:0722/155252.805996:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1425:1425:0722/155252.806313:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
Attempt to import unsupported winsys offset 1024
[1455:12:0722/155252.806724:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=700000 duration=33333 size=1836 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.807499:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.807241:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1425:1425:0722/155252.807822:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1425:1549:0722/155252.807604:VERBOSE1:v4l2_video_decode_accelerator.cc(2049)] NotifyError():
[1425:1425:0722/155252.808258:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=1 texture_id=117
[1425:1549:0722/155252.808321:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.808711:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1425:1425:0722/155252.809123:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=2
[1425:1425:0722/155252.809506:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1455:12:0722/155252.809757:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.810023:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.809964:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1455:12:0722/155252.810286:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=466667 duration=33333 size=1267 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.810309:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1425:1425:0722/155252.810824:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1455:12:0722/155252.810755:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.811243:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 122
[1425:1549:0722/155252.811171:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.811627:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1425:1425:0722/155252.812680:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1425:1425:0722/155252.813081:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 123
[1425:1425:0722/155252.813480:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1425:1425:0722/155252.813826:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1425:1425:0722/155252.814144:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 124
[1425:1425:0722/155252.814457:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1425:1425:0722/155252.814762:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
Attempt to import unsupported winsys offset 1024
[1425:1425:0722/155252.815397:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1425:1425:0722/155252.815907:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1425:1425:0722/155252.816343:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=2 texture_id=128
[1425:1425:0722/155252.816695:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1425:1425:0722/155252.817030:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=3
[1425:1425:0722/155252.817461:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1425:1425:0722/155252.817814:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1425:1425:0722/155252.818133:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1425:1425:0722/155252.818468:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1425:1425:0722/155252.818803:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 128
[1455:12:0722/155252.820013:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.820576:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.819215:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1455:12:0722/155252.821276:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=266667 duration=33333 size=160 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.821508:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1425:1425:0722/155252.821918:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 129
[1455:12:0722/155252.822047:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.822253:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1425:1425:0722/155252.823958:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1425:1549:0722/155252.822483:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.824282:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 130
[1455:12:0722/155252.825736:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.826048:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.826006:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1455:12:0722/155252.826340:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=300000 duration=33333 size=310 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.826373:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
Attempt to import unsupported winsys offset 1024
[1455:12:0722/155252.826665:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.827464:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.827189:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1425:1425:0722/155252.829014:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1425:1425:0722/155252.829531:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=3 texture_id=129
[1425:1425:0722/155252.829894:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1455:12:0722/155252.828113:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.830681:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.831106:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=333333 duration=33333 size=447 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.831766:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.830393:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=4
[1425:1549:0722/155252.832462:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.832729:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1425:1425:0722/155252.833083:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1455:12:0722/155252.833434:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.833382:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1455:12:0722/155252.833620:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.833790:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1455:12:0722/155252.833992:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=366667 duration=33333 size=361 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.834132:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 134
[1455:12:0722/155252.834260:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.834565:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1425:1425:0722/155252.834812:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1425:1425:0722/155252.835073:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 135
[1425:1425:0722/155252.835320:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1425:1425:0722/155252.835583:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1425:1549:0722/155252.835572:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1455:12:0722/155252.836262:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.837332:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.835863:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 136
[1455:12:0722/155252.837692:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=400000 duration=33333 size=387 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.837842:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1455:12:0722/155252.837969:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.838331:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
[1425:1549:0722/155252.838484:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
Attempt to import unsupported winsys offset 1024
[1455:12:0722/155252.839072:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.839071:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1455:12:0722/155252.839308:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.839611:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=433333 duration=33333 size=307 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.839520:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1455:12:0722/155252.839850:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.840013:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=4 texture_id=130
[1425:1549:0722/155252.840337:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.840295:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1455:12:0722/155252.840792:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.840672:VERBOSE3:v4l2_video_decode_accelerator.cc(477)] CreateEGLImageFor(): index=5
[1455:12:0722/155252.840985:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.841224:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=500000 duration=33333 size=436 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.841025:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[1455:12:0722/155252.841461:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.841637:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[1425:1549:0722/155252.841780:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.842068:VERBOSE1:generic_v4l2_device.cc(246)] Width: 32
[1425:1425:0722/155252.842317:VERBOSE1:generic_v4l2_device.cc(247)] Height: 32
[1425:1425:0722/155252.842573:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 140
[1455:12:0722/155252.842725:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.842985:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.842913:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[1455:12:0722/155252.843251:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=533333 duration=33333 size=388 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.843652:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 32
[1455:12:0722/155252.843801:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.844097:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.844050:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 141
[1425:1425:0722/155252.844376:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 1024
[1455:12:0722/155252.844723:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.844630:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 16
[1455:12:0722/155252.846062:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.846342:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=566667 duration=33333 size=393 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.846239:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 142
[1425:1425:0722/155252.846528:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 1280
[1425:1425:0722/155252.846981:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 16
[1455:12:0722/155252.846577:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.846858:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
Attempt to import unsupported winsys offset 1024
[1455:12:0722/155252.848620:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.848836:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.849049:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=600000 duration=33333 size=396 is_key_frame=0 encrypted=0}
[1425:1425:0722/155252.848866:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[1425:1425:0722/155252.849422:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[1455:12:0722/155252.849263:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1549:0722/155252.849648:VERBOSE2:v4l2_video_decode_accelerator.cc(862)] DecodeTask(): early out: kError state
[1425:1425:0722/155252.851265:ERROR:v4l2_video_decode_accelerator.cc(500)] could not create EGLImageKHR, index=5 texture_id=131
[1455:12:0722/155252.851612:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1425:1425:0722/155252.851575:VERBOSE1:v4l2_video_decode_accelerator.cc(502)] CreateEGLImageFor(): Setting error state:4
[1455:12:0722/155252.851771:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1425:1425:0722/155252.853318:VERBOSE1:v4l2_video_decode_accelerator.cc(2049)] NotifyError():
[1455:12:0722/155252.856085:VERBOSE3:mojo_video_decoder.cc(226)] ewanr: Decode: {timestamp=633333 duration=33333 size=441 is_key_frame=0 encrypted=0}
[1455:12:0722/155252.857237:VERBOSE3:mojo_video_decoder.cc(362)] ewanr: GetMaxDecodeRequests
[1455:12:0722/155252.858032:ERROR:batching_media_log.cc(38)] MediaEvent: {"error":"VDA Error 4"}
[1455:12:0722/155252.858498:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.858731:VERBOSE3:mojo_video_decoder.cc(483)] ewanr: Report Media.MojoVideoDecoder.InitialPlaybackErrorCodecCounter:1
[1455:12:0722/155252.859452:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.859857:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.860310:VERBOSE3:mojo_video_decoder.cc(307)] ewanr: OnDecodeDone
[1455:12:0722/155252.869484:VERBOSE1:mojo_video_decoder.cc(128)] ewanr: ~MojoVideoDecoder
[1425:1425:0722/155252.872039:VERBOSE2:v4l2_video_decode_accelerator.cc(793)] Destroy():
[1425:1549:0722/155252.873541:VERBOSE2:v4l2_video_decode_accelerator.cc(1828)] DestroyTask():
[1425:1549:0722/155252.878150:VERBOSE2:v4l2_video_decode_accelerator.cc(1925)] StopOutputStream():
[1425:1549:0722/155252.878402:VERBOSE2:v4l2_video_decode_accelerator.cc(1944)] StopInputStream():
[1425:1549:0722/155252.882209:VERBOSE1:v4l2_device.cc(1262)] Streamoff(): (OUTPUT_MPLANE) ewanr: VIDIOC_STREAMOFF
[1425:1549:0722/155252.882538:VERBOSE2:v4l2_video_decode_accelerator.cc(2433)] DestroyInputBuffers():
[1425:1549:0722/155252.888047:VERBOSE1:v4l2_device.cc(1104)] DeallocateBuffers(): (OUTPUT_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1549:0722/155252.888316:VERBOSE2:v4l2_video_decode_accelerator.cc(2443)] DestroyOutputBuffers():
[1425:1549:0722/155252.888863:VERBOSE1:v4l2_device.cc(1104)] DeallocateBuffers(): (CAPTURE_MPLANE) ewanr: VIDIOC_REQBUFS
[1425:1425:0722/155252.889920:VERBOSE2:v4l2_video_decode_accelerator.cc(814)] Destroy(): Destroyed.
[1425:1425:0722/155253.883513:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1
[1425:1425:0722/155253.884696:WARNING:ipc_message_attachment_set.cc(49)] MessageAttachmentSet destroyed with unconsumed attachments: 0/1
[1398:1398:0722/155255.801968:ERROR:tab_manager_delegate_chromeos.cc(392)] Failed to set oom_score_adj to 300 for focused tab, pid: 1637
[1398:1398:0722/155256.663780:WARNING:drivefs_session.cc(62)] DriveFs mount failed with error: 3
[1398:1398:0722/155301.213919:WARNING:service_connection.cc(166)] ML Service Mojo connection closed
^C[1398:1398:0722/155304.280297:WARNING:pref_notifier_impl.cc(40)] Pref observer for native_printing.external_print_servers_whitelist found at shutdown.
[1398:1398:0722/155304.280526:WARNING:pref_notifier_impl.cc(40)] Pref observer for sync.oobe_completed found at shutdown.
[1398:1398:0722/155304.347750:WARNING:pref_notifier_impl.cc(40)] Pref observer for media_router.cast_allow_all_ips found at shutdown.
[1398:1398:0722/155304.347816:WARNING:pref_notifier_impl.cc(40)] Pref observer for browser.relaunch_notification found at shutdown.
[1398:1398:0722/155304.348100:WARNING:pref_notifier_impl.cc(40)] Pref observer for browser.relaunch_heads_up_period found at shutdown.
pi@ewanrpi4:~/chromium/dev/src/out/Ozone_ARM_V4L2_Release $

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:13 pm

This is the dmesg output for the same run:

Code: Select all

[  252.642443] video10: VIDIOC_ENUM_FMT: index=0, type=vid-out-mplane, flags=0x1, pixelformat=H264, description='H.264'
[  252.642663] video10: VIDIOC_ENUM_FMT: index=1, type=vid-out-mplane, flags=0x1, pixelformat=MJPG, description='Motion-JPEG'
[  252.642865] video10: VIDIOC_ENUM_FMT: index=2, type=vid-out-mplane, flags=0x1, pixelformat=VP80, description='VP8'
[  252.643058] video10: VIDIOC_ENUM_FMT: error -22: index=3, type=vid-out-mplane, flags=0x0, pixelformat=
[  252.643256] bcm2835-codec bcm2835-codec: bcm2835_codec_release: Releasing instance 576f181e
[  252.643970] video10: VIDIOC_ENUM_FMT: index=0, type=vid-out-mplane, flags=0x1, pixelformat=H264, description='H.264'
[  252.644153] video10: VIDIOC_ENUM_FMT: index=1, type=vid-out-mplane, flags=0x1, pixelformat=MJPG, description='Motion-JPEG'
[  252.644513] video10: VIDIOC_ENUM_FMT: index=2, type=vid-out-mplane, flags=0x1, pixelformat=VP80, description='VP8'
[  252.644821] video10: VIDIOC_ENUM_FMT: error -22: index=3, type=vid-out-mplane, flags=0x0, pixelformat=
[  252.645063] video10: VIDIOC_ENUM_FRAMESIZES: index=0, pixelformat=H264, type=3, min=32x32, max=1920x1920, step=1x1
[  252.645312] video10: VIDIOC_QUERYCTRL: error -22: id=0x990a6b, type=0, name=, min/max=0/0, step=0, default=0, flags=0x00000000
[  252.645333] video10: VIDIOC_ENUM_FRAMESIZES: index=0, pixelformat=VP80, type=3, min=32x32, max=1920x1920, step=1x1
[  252.645591] bcm2835-codec bcm2835-codec: bcm2835_codec_release: Releasing instance da694b81
[  254.116090] video10: VIDIOC_ENUM_FMT: index=0, type=vid-out-mplane, flags=0x1, pixelformat=H264, description='H.264'
[  254.116473] video10: VIDIOC_ENUM_FMT: index=1, type=vid-out-mplane, flags=0x1, pixelformat=MJPG, description='Motion-JPEG'
[  254.117054] video10: VIDIOC_ENUM_FMT: index=2, type=vid-out-mplane, flags=0x1, pixelformat=VP80, description='VP8'
[  254.117440] video10: VIDIOC_ENUM_FMT: error -22: index=3, type=vid-out-mplane, flags=0x0, pixelformat=
[  254.117797] bcm2835-codec bcm2835-codec: bcm2835_codec_release: Releasing instance b8c77043
[  254.118601] video10: VIDIOC_QUERYCAP: driver=bcm2835-codec, card=bcm2835-codec-decode, bus=platform:bcm2835-codec, version=0x00041376, capabilities=0x84204000, device_caps=0x04204000
[  254.118669] video10: VIDIOC_REQBUFS: count=0, type=vid-out-mplane, memory=mmap
[  254.119199] video10: VIDIOC_REQBUFS: count=0, type=vid-cap-mplane, memory=mmap
[  254.119592] video10: VIDIOC_ENUM_FRAMESIZES: index=0, pixelformat=H264, type=3, min=32x32, max=1920x1920, step=1x1
[  254.119896] video10: VIDIOC_ENUM_FMT: index=0, type=vid-out-mplane, flags=0x1, pixelformat=H264, description='H.264'
[  254.119921] bcm2835-codec bcm2835-codec: Setting format for type 10, wxh: 0x0, fmt: H264, size 524288
[  254.119926] bcm2835-codec bcm2835-codec: Calulated bpl as 0, size 524288
[  254.119930] video10: VIDIOC_S_FMT: type=vid-out-mplane, width=0, height=0, format=H264, field=none, colorspace=3, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.119942] plane 0: bytesperline=0 sizeimage=524288
[  254.119951] video10: VIDIOC_ENUM_FMT: index=0, type=vid-cap-mplane, flags=0x0, pixelformat=YU12, description='Planar YUV 4:2:0'
[  254.120293] video10: VIDIOC_ENUM_FMT: index=1, type=vid-cap-mplane, flags=0x0, pixelformat=YV12, description='Planar YVU 4:2:0'
[  254.121299] bcm2835-codec bcm2835-codec: Setting format for type 9, wxh: 32x32, fmt: YV12, size 1536
[  254.121305] bcm2835-codec bcm2835-codec: Calulated bpl as 32, size 1536
[  254.121311] video10: VIDIOC_S_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.121325] plane 0: bytesperline=32 sizeimage=1536
[  254.122092] video10: VIDIOC_SUBSCRIBE_EVENT: type=0x5, id=0x0, flags=0x0
[  254.122478] video10: VIDIOC_G_FMT: type=vid-out-mplane, width=0, height=0, format=H264, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.122495] plane 0: bytesperline=0 sizeimage=524288
[  254.133078] bcm2835-codec bcm2835-codec: bcm2835_codec_create_component: component created as ril.video_decode
[  254.133536] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb ed87d059
[  254.133838] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb a5adf41e
[  254.134800] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 5f420a55
[  254.137625] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 674986e6
[  254.138163] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 0127f985
[  254.138583] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 2aa3dc8a
[  254.140762] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 051d6d09
[  254.152356] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 348bfb2b
[  254.152370] video10: VIDIOC_REQBUFS: count=8, type=vid-out-mplane, memory=mmap
[  254.154516] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.154533] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.154539] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.155603] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=1, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.155619] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x80000, length=524288
[  254.155624] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.156801] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=2, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.156820] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x100000, length=524288
[  254.156826] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.158115] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=3, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.158133] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x180000, length=524288
[  254.158139] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.159252] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=4, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.159267] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x200000, length=524288
[  254.159272] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.160314] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=5, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.160329] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x280000, length=524288
[  254.160334] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.161239] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=6, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.161257] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x300000, length=524288
[  254.161262] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.162328] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=7, type=vid-out-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.162343] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x380000, length=524288
[  254.162348] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.163298] video10: VIDIOC_TRY_DECODER_CMD: cmd=1, flags=0x0
[  254.163308] pts=0
[  254.163669] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr ed87d059
[  254.165600] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr ed87d059 vbuf->flags 0, seq 0, bytesused 31
[  254.165609] bcm2835-codec bcm2835-codec: bcm2835_codec_start_streaming: type: 10 count 1
[  254.169917] video10: VIDIOC_STREAMON: type=vid-out-mplane
[  254.170515] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.170532] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.170537] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.171153] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr a5adf41e
[  254.171178] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr a5adf41e vbuf->flags 0, seq 0, bytesused 9
[  254.172468] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.172499] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.172505] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.175410] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr 5f420a55
[  254.175435] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr 5f420a55 vbuf->flags 0, seq 0, bytesused 702
[  254.178512] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.178533] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.178539] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.193499] video10: VIDIOC_G_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.193519] plane 0: bytesperline=32 sizeimage=1536
[  254.196125] video10: VIDIOC_G_SELECTION: type=vid-cap, target=256, flags=0x0, wxh=32x0, x,y=0,0
[  254.197968] video10: VIDIOC_DQEVENT: error -2: type=0x0, pending=0, sequence=0, id=0, timestamp=0.000000000
[  254.198476] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.198494] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.198500] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.208052] video10: VIDIOC_G_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.208073] plane 0: bytesperline=32 sizeimage=1536
[  254.208450] video10: VIDIOC_G_SELECTION: type=vid-cap, target=256, flags=0x0, wxh=32x0, x,y=0,0
[  254.213174] video10: VIDIOC_G_EXT_CTRLS: which=0x0, count=1, error_idx=0, id/val=0x980927/0x1
[  254.220951] video10: VIDIOC_G_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
[  254.220971] plane 0: bytesperline=32 sizeimage=1536
[  254.221645] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 8766e5a4
[  254.221685] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb e0b62f0c
[  254.221709] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 8b350d88
[  254.221732] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 5845ff8a
[  254.221759] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb 5ba34165
[  254.221799] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_init: ctx:d6774659, vb a515cca5
[  254.221807] video10: VIDIOC_REQBUFS: count=6, type=vid-cap-mplane, memory=mmap
[  254.222361] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.222380] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40000000, length=1536
[  254.222386] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.222811] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=1, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.222829] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40001000, length=1536
[  254.222834] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.223168] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=2, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.223185] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40002000, length=1536
[  254.223191] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.223494] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=3, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.223510] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40003000, length=1536
[  254.223516] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.223866] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=4, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.223887] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40004000, length=1536
[  254.223892] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.224251] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=5, type=vid-cap-mplane, flags=0x00004000, field=any, sequence=0, memory=mmap
[  254.224268] plane 0: bytesused=0, data_offset=0x00000000, offset/userptr=0x40005000, length=1536
[  254.224273] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.224753] video10: VIDIOC_EXPBUF: fd=79, type=vid-cap-mplane, index=0, plane=0, flags=0x00080000
[  254.225866] video10: VIDIOC_EXPBUF: fd=111, type=vid-cap-mplane, index=1, plane=0, flags=0x00080000
[  254.225988] video10: VIDIOC_EXPBUF: fd=119, type=vid-cap-mplane, index=2, plane=0, flags=0x00080000
[  254.226029] video10: VIDIOC_EXPBUF: fd=125, type=vid-cap-mplane, index=3, plane=0, flags=0x00080000
[  254.226076] video10: VIDIOC_EXPBUF: fd=131, type=vid-cap-mplane, index=4, plane=0, flags=0x00080000
[  254.226121] video10: VIDIOC_EXPBUF: fd=137, type=vid-cap-mplane, index=5, plane=0, flags=0x00080000
[  254.226224] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr 674986e6
[  254.226240] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr 674986e6 vbuf->flags 0, seq 0, bytesused 413
[  254.239573] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr 0127f985
[  254.239600] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr 0127f985 vbuf->flags 0, seq 0, bytesused 12283
[  254.315080] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: type: 10 - return buffers
[  254.315092] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: return buffer ed87d059
[  254.315100] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: return buffer a5adf41e
[  254.315107] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: return buffer 5f420a55
[  254.315113] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: return buffer 674986e6
[  254.315120] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: return buffer 0127f985
[  254.317537] bcm2835-codec bcm2835-codec: bcm2835_codec_stop_streaming: done
[  254.317548] video10: VIDIOC_STREAMOFF: type=vid-out-mplane
[  254.318512] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb ed87d059
[  254.318519] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb a5adf41e
[  254.318524] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 5f420a55
[  254.318529] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 674986e6
[  254.318533] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 0127f985
[  254.318539] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 2aa3dc8a
[  254.318543] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 051d6d09
[  254.318548] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 348bfb2b
[  254.323255] video10: VIDIOC_REQBUFS: count=0, type=vid-out-mplane, memory=mmap
[  254.324178] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 8766e5a4
[  254.324188] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb e0b62f0c
[  254.324193] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 8b350d88
[  254.324199] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 5845ff8a
[  254.324204] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb 5ba34165
[  254.324209] bcm2835-codec bcm2835-codec: bcm2835_codec_buffer_cleanup: ctx:d6774659, vb a515cca5
[  254.324251] video10: VIDIOC_REQBUFS: count=0, type=vid-cap-mplane, memory=mmap
[  254.324571] bcm2835-codec bcm2835-codec: bcm2835_codec_release: Releasing instance d6774659

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:29 pm

I popped some logging in V4L2VideoDecodeAccelerator::FinishResolutionChange and we get:

Code: Select all

[2617:2744:0722/162242.868687:VERBOSE1:v4l2_video_decode_accelerator.cc(2014)] FinishResolutionChange(): ret=1, again=0
[2617:2744:0722/162242.869055:VERBOSE2:v4l2_video_decode_accelerator.cc(2145)] CreateBuffersForFormat(): new resolution: 32x32, visible size: 32x32, decoder output planes count: , EGLImage size: 32x32, EGLImage plane count: 1

With a corresponding dmesg log:

Code: Select all

[ 2044.306577] video10: VIDIOC_G_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:43 pm

I'm confused from the kernel logs.

Code: Select all

[  254.163308] pts=0
[  254.163669] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr ed87d059
[  254.165600] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr ed87d059 vbuf->flags 0, seq 0, bytesused 31
   Presumably this is the header bytes being queued, but we're not streaming as yet. 31 bytes.
   
[  254.165609] bcm2835-codec bcm2835-codec: bcm2835_codec_start_streaming: type: 10 count 1
[  254.169917] video10: VIDIOC_STREAMON: type=vid-out-mplane
[  254.170515] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.170532] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.170537] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.171153] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr a5adf41e
[  254.171178] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr a5adf41e vbuf->flags 0, seq 0, bytesused 9
   More header bytes? 9 bytes is very short otherwise.

[  254.172468] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.172499] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.172505] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000
[  254.175410] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr 5f420a55
[  254.175435] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr 5f420a55 vbuf->flags 0, seq 0, bytesused 702
   First I-frame? Very small if so.

[  254.178512] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, flags=0x00004003, field=none, sequence=0, memory=mmap
[  254.178533] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  254.178539] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000

[  254.193499] video10: VIDIOC_G_FMT: type=vid-cap-mplane, width=32, height=32, format=YV12, field=none, colorspace=0, num_planes=1, flags=0x0, ycbcr_enc=0, quantization=0, xfer_func=0
 Spontaneous G_FMT
 
[  254.193519] plane 0: bytesperline=32 sizeimage=1536
[  254.196125] video10: VIDIOC_G_SELECTION: type=vid-cap, target=256, flags=0x0, wxh=32x0, x,y=0,0

[  254.197968] video10: VIDIOC_DQEVENT: error -2: type=0x0, pending=0, sequence=0, id=0, timestamp=0.000000000
   Error dequeueing an event?
(I think I forgot to check which kernel version you're on - I hope 5.4.)

https://github.com/raspberrypi/linux/bl ... dec.c#L819
handle_fmt_changed should have logged a message (at debug level 1) on the resolution change. There's no sign of it in the logs, so what triggered Chromium into the resolution changed? Something's missing.
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 3:48 pm

Ah, I'm running on 4.19.118... I will switch to 5.4 and give this all another try...

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 4:40 pm

Looks like I will have to put V4L2 on the back burner for the moment. I have upgraded the kernel to 5.4.45 which appears to make minigbm unhappy:

Code: Select all

MINIGBM: CREATE! Format: AR24
MINIGBM: CREATE_FOR_MODIFIER! Format: DRM_FORMAT_MOD_LINEAR
[minigbm:vc4.c(76)] DRM_IOCTL_VC4_GEM_CREATE failed (size=8294400)
[9229:9229:0722/173710.768941:ERROR:gpu_memory_buffer_factory_native_pixmap.cc(247)] Failed to create pixmap 1920x1080, BGRA_8888, usage GPU_READ
[9229:9229:0722/173710.769139:ERROR:shared_image_backing_factory_gl_texture.cc(1478)] CreateSharedImage: Failed to create bindable image
[9229:9229:0722/173710.769303:ERROR:shared_image_factory.cc(509)] CreateSharedImage: could not create backing.
[9229:9229:0722/173710.813220:ERROR:shared_image_factory.cc(275)] DestroySharedImage: Could not find shared image mailbox

I'll post the output of the VDA once I've got it back up and running.

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Wed Jul 22, 2020 5:11 pm

Looking at the diffs there's nothing significant in bcm2835-codec that has changed between 4.19 and 5.4.

As to what has changed on the rendering side, I suspect a fair amount.
Had you updated your whole distribution, or just kernel and firmware? Mesa plays a big part in all things 3D/GL/GLES/EGL, and that gets fairly frequent updates too (more frequent than Debian does).
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Thu Jul 23, 2020 8:57 am

I have not personally noticed any differences in V4L2 between 4.19 and 5.4, but I don't know very much about the backed of course.

I have only upgraded the kernel so perhaps this is why I'm running into issues. Maybe it's worth sticking to 4.19 if I can continue to address V4L2 first.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Fri Jul 24, 2020 12:00 pm

Have reverted changes to the kernel in order to run this on 5.4. I'm getting the same behaviour.

I get the same kernel log you noted above:

Code: Select all

[  239.310384] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_prepare: type: 10 ptr 92926517
[  239.311136] bcm2835-codec bcm2835-codec: bcm2835_codec_buf_queue: type: 10 ptr 92926517 vbuf->flags 0, seq 0, bytesused 31
[  239.311149] bcm2835-codec bcm2835-codec: bcm2835_codec_start_streaming: type: 10 count 1
[  239.314109] video10: VIDIOC_STREAMON: type=vid-out-mplane
[  239.314887] video10: VIDIOC_QUERYBUF: 00:00:00.00000000 index=0, type=vid-out-mplane, request_fd=0, flags=0x00004003, field=none, sequence=0, memory=mmap
[  239.314906] plane 0: bytesused=31, data_offset=0x00000000, offset/userptr=0x0, length=524288
[  239.314913] timecode=00:00:00 type=0, flags=0x00000000, frames=0, userbits=0x00000000

And there is no sign of a resolution change from handle_fmt_changed. This seems related to the behaviour I saw when attempting to use the new VideoDecoder (as opposed to VDA). The VD would dequeue the resolution change from V4L2 and move to the "decode" state, but would constantly hit resolution change events that shouldn't have been triggered. Seems that finding the source of these unnecessary events will be useful.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Fri Jul 24, 2020 2:49 pm

This appears to be the culprit. If the "coded_size_" is empty, and G_FMT doesn't return EINVAL, then Chromium will trigger a resolution change regardless.

As we know that the Raspberry Pi does trigger a resolution change event, I have removed this and we no longer get any EGL errors. Unfortunately, we still never get a resolution change and thus never start decoding. I believe this might be because the capture queue has no been set up yet. I have found before that the Pi seems to require you to allocate capture buffers during initialisation or it won't start streaming the output queue. This was the case with the VideoDecoder.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Fri Jul 24, 2020 3:43 pm

I was right, I needed to allocate capture buffers during initialisation. I now get a resolution change, which returns 1920x1088/1920x1080:

Code: Select all

[13736.174226] bcm2835-codec bcm2835-codec: handle_fmt_changed: Format changed: buff size min 3133440, rec 3133440, buff num min 1, rec 1
[13736.174233] bcm2835-codec bcm2835-codec: handle_fmt_changed: Format changed to 1920x1088, crop 1920x1080, colourspace 00000000
[13736.174241] bcm2835-codec bcm2835-codec: handle_fmt_changed: Format was 32x32, crop 32x0

Unfortunately, I still get the same EGL error:

Code: Select all

[5799:5799:0724/163442.926294:VERBOSE3:v4l2_video_decode_accelerator.cc(483)] CreateEGLImageFor(): index=1
[5799:5799:0724/163442.926666:VERBOSE1:generic_v4l2_device.cc(225)] CreateEGLImage():
[5799:5799:0724/163442.927000:VERBOSE1:generic_v4l2_device.cc(245)] Num planes: 3
[5799:5799:0724/163442.927352:VERBOSE1:generic_v4l2_device.cc(246)] Width: 1920
[5799:5799:0724/163442.927747:VERBOSE1:generic_v4l2_device.cc(247)] Height: 1080
[5799:5799:0724/163442.928160:VERBOSE1:generic_v4l2_device.cc(250)] Plane 0 handle: 110
[5799:5799:0724/163442.928845:VERBOSE1:generic_v4l2_device.cc(251)] Plane 0 offset: 0
[5799:5799:0724/163442.929155:VERBOSE1:generic_v4l2_device.cc(252)] Plane 0 stride: 1920
[5799:5799:0724/163442.929448:VERBOSE1:generic_v4l2_device.cc(250)] Plane 1 handle: 111
[5799:5799:0724/163442.929738:VERBOSE1:generic_v4l2_device.cc(251)] Plane 1 offset: 2088960
[5799:5799:0724/163442.930009:VERBOSE1:generic_v4l2_device.cc(252)] Plane 1 stride: 960
[5799:5799:0724/163442.932704:VERBOSE1:generic_v4l2_device.cc(250)] Plane 2 handle: 112
[5799:5799:0724/163442.934381:VERBOSE1:generic_v4l2_device.cc(251)] Plane 2 offset: 2611200
[5799:5799:0724/163442.934636:VERBOSE1:generic_v4l2_device.cc(252)] Plane 2 stride: 960
Attempt to import unsupported winsys offset 2088960
[5799:5799:0724/163442.935046:ERROR:gl_surface_egl.cc(741)] EGL Driver message (Critical) eglCreateImageKHR: eglCreateImage failed with 0x00003003
[5799:5799:0724/163442.935230:VERBOSE1:generic_v4l2_device.cc(305)] CreateEGLImage(): Failed creating EGL image: EGL_BAD_ALLOC
[5799:5799:0724/163442.935385:ERROR:v4l2_video_decode_accelerator.cc(506)] could not create EGLImageKHR, index=1 texture_id=70
[5799:5799:0724/163442.935540:VERBOSE1:v4l2_video_decode_accelerator.cc(508)] CreateEGLImageFor(): Setting error state:4

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Mon Aug 10, 2020 4:29 pm

After delving into what's happening in Mesa, I have found the cause of the problem.

Chromium is creating EGL images for V3D, which means it runs v3d_resource_from_handle. Here, rsc->tiled will be true if the modifier is DRM_FORMAT_MOD_BROADCOM_UIF, or if the modifier is DRM_FORMAT_MOD_INVALID and screen->ro == NULL:

Code: Select all

switch (whandle->modifier) {
case DRM_FORMAT_MOD_LINEAR:
        rsc->tiled = false;
        break;
case DRM_FORMAT_MOD_BROADCOM_UIF:
        rsc->tiled = true;
        break;
case DRM_FORMAT_MOD_INVALID:
        rsc->tiled = screen->ro == NULL;
        break;
default:
        fprintf(stderr,
                "Attempt to import unsupported modifier 0x%llx\n",
                (long long)whandle->modifier);
        goto fail;
}

Up the stack a bit, dri2_from_dma_bufs calls dri2_create_image_from_fd, and specifies the modifier as DRM_FORMAT_MOD_INVALID. In v3d_resource_from_handle, screen->ro ends up being NULL, rsc->tiled is true, and our error gets thrown because the offsets are unsupported.

I have remedied this by either forcing rsc->tiled to be false, or passing DRM_FORMAT_MOD_LINEAR to dri2_create_image_from_fd. Either one will return successfully and our video plays. (The video stutters and errors out after a few seconds, but I'm over this hurdle at least!).

Do you think Mesa is at fault here? Or could it still be the way Chromium requests the buffers?

6by9
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 11464
Joined: Wed Dec 04, 2013 11:27 am
Location: ZZ9 Plural Z Alpha, aka just outside Cambridge.

Re: eglCreateImage fails when playing video in Chromium

Mon Aug 10, 2020 4:50 pm

I'm well out of my depth here. I can bounce it off our contractors who look after Mesa for us.
The alternative is to post an issue on https://gitlab.freedesktop.org/mesa/mesa/, but it may get ignored.

There is an interesting commit from Eric when he added UIF support https://gitlab.freedesktop.org/mesa/mes ... e3803928ae INVALID went from "rsc->tiled = false;" to true.
It was then amended with https://gitlab.freedesktop.org/mesa/mes ... 3f45d05ddc


Can I be nosey and ask for more details of your build config for Chromium? We're looking at the video rendering paths through Chromium for X11, and those currently seem a little deficient in efficient handling. You seem to be a couple of steps ahead of us in your use of the Ozone abstraction layer. If it is commercially sensitive then email me instead.
Software Engineer at Raspberry Pi Trading. Views expressed are still personal views.
I'm not interested in doing contracts for bespoke functionality - please don't ask.

ewanr-bbc
Posts: 40
Joined: Mon Sep 09, 2019 3:18 pm
Location: London, UK

Re: eglCreateImage fails when playing video in Chromium

Tue Aug 11, 2020 9:42 am

Thanks for this, interesting to see the commits that Eric made. I will raise an issue on the Mesa repo.
I will drop you an email re: our Chromium build.

yaegashi
Posts: 2
Joined: Tue Aug 11, 2020 2:49 pm
Location: Tokyo
Contact: Twitter

Re: eglCreateImage fails when playing video in Chromium

Tue Aug 11, 2020 4:01 pm

Hi ewanr-bbc,

Also interested in your chromium build recipe. Would you be kind enough to share it with me?

I used to build chromium content_shell on Ozone/dispmanx for RPi3 about in 2017: https://github.com/yaegashi/ozone-dispmanx

Today I've just begin exploring chromium on Ozone/GBM for RPi4. I saw the first built executable saying "Platform device extensions not found" followed by SEGV_MAPERR. I'm now waiting the next build done with is_debug = true...

Return to “Graphics programming”