[90.053489] Initializing watchdogs
[90.053694]   /dev/watchdog0
[90.091140] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[90.105803] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[90.111749] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[90.117208] [001/133] (960s left) kms_busy (extended-modeset-hang-newfb)
[90.322768] Starting subtest: extended-modeset-hang-newfb
[90.323896] Starting dynamic subtest: pipe-A
[98.967959] Dynamic subtest pipe-A: SUCCESS (8.638s)
[98.990905] Starting dynamic subtest: pipe-C
[106.930169] Dynamic subtest pipe-C: SUCCESS (7.952s)
[106.934205] Subtest extended-modeset-hang-newfb: SUCCESS (16.609s)
[107.284324] [002/133] (943s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[107.476949] Starting subtest: plane-upscale-factor-0-25-with-rotation
[107.477977] Starting dynamic subtest: pipe-A
[111.654380] Dynamic subtest pipe-A: SKIP (4.180s)
[111.682670] Starting dynamic subtest: pipe-B
[115.853174] Dynamic subtest pipe-B: SKIP (4.194s)
[115.882253] Starting dynamic subtest: pipe-C
[120.056262] Dynamic subtest pipe-C: SKIP (4.203s)
[120.061170] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (12.581s)
[120.540440] [003/133] (930s left) gem_pxp (fail-invalid-protected-context)
[123.220953] Starting subtest: fail-invalid-protected-context
[123.223399] Subtest fail-invalid-protected-context: SKIP (0.000s)
[123.374154] [004/133] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[123.579617] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[125.635213] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.057s)
[125.856705] [005/133] (925s left) kms_properties (colorop-properties-legacy)
[126.034886] Starting subtest: colorop-properties-legacy
[126.044739] Starting dynamic subtest: pipe-A-HDMI-A-1
[126.527723] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.483s)
[126.564641] Starting dynamic subtest: pipe-A-HDMI-A-2
[126.920543] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.382s)
[126.958274] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.260958] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.334s)
[127.299375] Starting dynamic subtest: pipe-B-HDMI-A-2
[127.593872] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.324s)
[127.623389] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.940383] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.342s)
[127.975364] Starting dynamic subtest: pipe-C-HDMI-A-2
[128.279588] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.315s)
[128.280683] Subtest colorop-properties-legacy: SUCCESS (2.243s)
[128.598388] [006/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[128.815639] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[131.789054] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.973s)
[132.081069] [007/133] (918s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[132.283905] Starting subtest: basic-modeset-with-all-modifiers-formats
[132.883197] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-RGB565
[133.252626] Dynamic subtest pipe-A-HDMI-A-1-yf-RGB565: SUCCESS (0.369s)
[133.273646] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XRGB8888
[133.302623] Dynamic subtest pipe-A-HDMI-A-1-yf-XRGB8888: SUCCESS (0.043s)
[133.322301] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XRGB2101010
[133.371631] Dynamic subtest pipe-A-HDMI-A-1-yf-XRGB2101010: SUCCESS (0.062s)
[133.387162] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-YUYV
[133.434647] Dynamic subtest pipe-A-HDMI-A-1-yf-YUYV: SUCCESS (0.063s)
[133.455793] Starting dynamic subtest: pipe-A-HDMI-A-1-yf-XYUV8888
[133.502572] Dynamic subtest pipe-A-HDMI-A-1-yf-XYUV8888: SUCCESS (0.061s)
[133.525805] Starting dynamic subtest: pipe-A-HDMI-A-1-y-RGB565
[133.786109] Dynamic subtest pipe-A-HDMI-A-1-y-RGB565: SUCCESS (0.278s)
[133.805054] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB8888
[133.853570] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB8888: SUCCESS (0.063s)
[133.870578] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB2101010
[133.918115] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB2101010: SUCCESS (0.063s)
[133.939034] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XRGB16161616F
[133.988238] Dynamic subtest pipe-A-HDMI-A-1-y-XRGB16161616F: SUCCESS (0.062s)
[134.003860] Starting dynamic subtest: pipe-A-HDMI-A-1-y-YUYV
[134.037545] Dynamic subtest pipe-A-HDMI-A-1-y-YUYV: SUCCESS (0.046s)
[134.062921] Starting dynamic subtest: pipe-A-HDMI-A-1-y-XYUV8888
[134.086568] Dynamic subtest pipe-A-HDMI-A-1-y-XYUV8888: SUCCESS (0.044s)
[134.104540] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[134.185151] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.095s)
[134.203631] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[134.236425] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.046s)
[134.254259] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[134.285168] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.044s)
[134.305068] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB16161616F
[134.334501] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB16161616F: SUCCESS (0.045s)
[134.354564] Starting dynamic subtest: pipe-A-HDMI-A-1-x-YUYV
[134.386641] Dynamic subtest pipe-A-HDMI-A-1-x-YUYV: SUCCESS (0.046s)
[134.404690] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XYUV8888
[134.435840] Dynamic subtest pipe-A-HDMI-A-1-x-XYUV8888: SUCCESS (0.044s)
[134.897672] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.613s)
[135.265448] [008/133] (915s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[135.453983] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[135.458356] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[135.596239] [009/133] (915s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[135.707206] Starting subtest: rel-constants-invalid-rel-gen5
[135.708460] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.001s)
[135.855868] [010/133] (915s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[136.033824] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[136.035621] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[136.164113] [011/133] (915s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[136.359243] Starting subtest: fbcpsr-indfb-scaledprimary
[136.363156] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[136.530339] [012/133] (914s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[136.711186] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[136.712015] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[147.778506] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.062s)
[147.797093] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[158.800262] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (11.017s)
[158.822537] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[169.798998] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.987s)
[169.801021] Subtest 2x-flip-vs-absolute-wf_vblank: SUCCESS (33.090s)
[170.436853] [013/133] (881s left) gem_exec_schedule (promotion)
[170.575524] Starting subtest: promotion
[170.576421] Starting dynamic subtest: rcs0
[170.702394] Dynamic subtest rcs0: SUCCESS (0.123s)
[170.724957] Starting dynamic subtest: bcs0
[170.849763] Dynamic subtest bcs0: SUCCESS (0.137s)
[170.865532] Starting dynamic subtest: vcs0
[170.966441] Dynamic subtest vcs0: SUCCESS (0.119s)
[170.989861] Starting dynamic subtest: vecs0
[171.092980] Dynamic subtest vecs0: SUCCESS (0.121s)
[171.095595] Subtest promotion: SUCCESS (0.520s)
[171.495945] [014/133] (880s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[171.604668] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[171.699784] [015/133] (880s left) gem_ctx_shared (disjoint-timelines)
[171.825436] Starting subtest: disjoint-timelines
[171.902961] Subtest disjoint-timelines: SUCCESS (0.076s)
[172.190224] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[172.195832] [016/133] (879s left) gem_userptr_blits (map-fixed-invalidate)
[172.342604] Starting subtest: map-fixed-invalidate
[172.344425] Starting dynamic subtest: gtt
[172.605990] Dynamic subtest gtt: SUCCESS (0.260s)
[172.626683] Starting dynamic subtest: wb
[172.773793] Dynamic subtest wb: SUCCESS (0.166s)
[172.794773] Starting dynamic subtest: wc
[172.939834] Dynamic subtest wc: SUCCESS (0.163s)
[172.962335] Starting dynamic subtest: uc
[173.107610] Dynamic subtest uc: SUCCESS (0.165s)
[173.112140] Subtest map-fixed-invalidate: SUCCESS (0.770s)
[173.326046] [017/133] (878s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[173.502951] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[173.512721] Starting dynamic subtest: pipe-A-valid-mode
[174.489776] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.978s)
[174.491202] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.984s)
[174.816326] [018/133] (877s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[175.035859] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[175.038817] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[175.215391] [019/133] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[175.429427] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[175.432330] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[175.598405] [020/133] (876s left) gem_ctx_persistence (engines-hang)
[175.713518] Starting subtest: engines-hang
[175.714694] Starting dynamic subtest: rcs0
[175.758432] Dynamic subtest rcs0: SUCCESS (0.045s)
[175.783084] Starting dynamic subtest: bcs0
[175.784973] Dynamic subtest bcs0: SKIP (0.005s)
[175.805333] Starting dynamic subtest: vcs0
[175.806318] Dynamic subtest vcs0: SUCCESS (0.035s)
[175.836423] Starting dynamic subtest: vecs0
[175.860633] Dynamic subtest vecs0: SUCCESS (0.049s)
[175.861698] Subtest engines-hang: SUCCESS (0.151s)
[176.036298] [021/133] (876s left) i915_pm_rpm (sysfs-read)
[177.970940] Starting subtest: sysfs-read
[178.182698] Subtest sysfs-read: SUCCESS (0.211s)
[178.585019] [022/133] (873s left) prime_vgem (coherency-blt)
[178.716477] Starting subtest: coherency-blt
[181.607393] Subtest coherency-blt: SUCCESS (2.888s)
[181.783417] [023/133] (870s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[181.883260] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[181.890672] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.004s)
[182.049832] [024/133] (870s left) gen9_exec_parse (batch-without-end)
[182.172519] Starting subtest: batch-without-end
[182.173376] Subtest batch-without-end: SUCCESS (0.003s)
[182.467341] [025/133] (870s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[182.673743] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[185.651065] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SUCCESS (2.974s)
[185.870282] [026/133] (866s left) gem_partial_pwrite_pread (writes-after-reads-display)
[185.982158] Starting subtest: writes-after-reads-display
[207.215186] Subtest writes-after-reads-display: SUCCESS (21.234s)
[207.389467] [027/133] (845s left) gem_wait (wait)
[207.521982] Starting subtest: wait
[207.523850] Starting dynamic subtest: all-engines
[208.562481] Dynamic subtest all-engines: SUCCESS (1.037s)
[208.583817] Starting dynamic subtest: rcs0
[209.597829] Dynamic subtest rcs0: SUCCESS (1.031s)
[209.619155] Starting dynamic subtest: bcs0
[210.628399] Dynamic subtest bcs0: SUCCESS (1.028s)
[210.651153] Starting dynamic subtest: vcs0
[211.658754] Dynamic subtest vcs0: SUCCESS (1.024s)
[211.676282] Starting dynamic subtest: vecs0
[212.687587] Dynamic subtest vecs0: SUCCESS (1.026s)
[212.688520] Subtest wait: SUCCESS (5.166s)
[213.003805] [028/133] (839s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[213.205986] Starting subtest: 4-tiled-32bpp-rotate-180
[213.209075] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[213.368187] [029/133] (839s left) kms_plane_multiple (tiling-yf)
[213.543905] Starting subtest: tiling-yf
[213.544999] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.476486] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.929s)
[215.506650] Starting dynamic subtest: pipe-A-HDMI-A-2
[217.271309] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.787s)
[217.324921] Starting dynamic subtest: pipe-B-HDMI-A-1
[219.061588] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.763s)
[219.085248] Starting dynamic subtest: pipe-B-HDMI-A-2
[220.828783] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.761s)
[220.855144] Starting dynamic subtest: pipe-C-HDMI-A-1
[222.547168] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.706s)
[222.573262] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.312830] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.738s)
[224.319863] Subtest tiling-yf: SUCCESS (10.768s)
[224.675395] [030/133] (828s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[224.892507] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[224.895601] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[225.073819] [031/133] (828s left) kms_color (ctm-0-75)
[225.250679] Starting subtest: ctm-0-75
[225.251582] Starting dynamic subtest: pipe-A-HDMI-A-1
[228.010712] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.758s)
[228.047360] Starting dynamic subtest: pipe-A-HDMI-A-2
[230.503420] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.490s)
[230.544237] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.973258] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.469s)
[233.017630] Starting dynamic subtest: pipe-B-HDMI-A-2
[235.398586] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.420s)
[235.421801] Starting dynamic subtest: pipe-C-HDMI-A-1
[237.815074] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.409s)
[237.862199] Starting dynamic subtest: pipe-C-HDMI-A-2
[240.220461] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.404s)
[240.223926] Subtest ctm-0-75: SUCCESS (14.975s)
[240.579357] [032/133] (812s left) kms_chamelium_frames (dp-crc-single)
[241.155313] Subtest dp-crc-single: SKIP (0.000s)
[241.427638] [033/133] (811s left) kms_draw_crc (draw-method-render)
[241.615156] Starting subtest: draw-method-render
[241.616060] Starting dynamic subtest: xrgb8888-untiled
[242.155174] Dynamic subtest xrgb8888-untiled: SUCCESS (0.541s)
[242.176649] Starting dynamic subtest: rgb565-untiled
[242.452800] Dynamic subtest rgb565-untiled: SUCCESS (0.295s)
[242.474046] Starting dynamic subtest: xrgb2101010-untiled
[242.754942] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.296s)
[242.783753] Starting dynamic subtest: xbgr16161616f-untiled
[243.086592] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.329s)
[243.108140] Starting dynamic subtest: xrgb8888-xtiled
[243.290828] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.197s)
[243.313885] Starting dynamic subtest: rgb565-xtiled
[243.487783] Dynamic subtest rgb565-xtiled: SUCCESS (0.194s)
[243.510467] Starting dynamic subtest: xrgb2101010-xtiled
[243.656558] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s)
[243.676806] Starting dynamic subtest: xbgr16161616f-xtiled
[243.838920] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[243.859289] Starting dynamic subtest: xrgb8888-ytiled
[244.021913] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.181s)
[244.045561] Starting dynamic subtest: rgb565-ytiled
[244.205209] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s)
[244.230611] Starting dynamic subtest: xrgb2101010-ytiled
[244.370646] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.162s)
[244.395313] Starting dynamic subtest: xbgr16161616f-ytiled
[244.555186] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.180s)
[244.557323] Subtest draw-method-render: SUCCESS (2.945s)
[244.822824] [034/133] (808s left) gem_softpin (safe-alignment)
[244.941285] Starting subtest: safe-alignment
[244.974768] Subtest safe-alignment: SUCCESS (0.031s)
[245.158477] [035/133] (808s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[245.350584] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[245.353325] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[245.525646] [036/133] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[245.726595] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[245.730220] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s)
[245.905908] [037/133] (807s left) gem_ctx_persistence (many-contexts)
[246.023498] Starting subtest: many-contexts
[278.867590] Subtest many-contexts: SUCCESS (32.844s)
[279.026217] [038/133] (774s left) gem_reg_read (bad-register)
[279.131734] Starting subtest: bad-register
[279.133106] Subtest bad-register: SUCCESS (0.000s)
[279.309490] [039/133] (774s left) kms_pm_dc (dc5-psr)
[280.499825] Starting subtest: dc5-psr
[280.503629] Subtest dc5-psr: SKIP (0.000s)
[280.797941] [040/133] (773s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[280.990808] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[284.244210] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.250s)
[284.570350] [041/133] (769s left) gem_ctx_engines (none)
[284.711485] Starting subtest: none
[284.718671] Subtest none: SUCCESS (0.007s)
[284.983401] [042/133] (769s left) kms_addfb_basic (no-handle)
[285.095484] Starting subtest: no-handle
[285.096402] Subtest no-handle: SUCCESS (0.000s)
[285.348911] [043/133] (768s left) i915_drm_fdinfo (busy-idle)
[285.461779] Starting subtest: busy-idle
[285.462805] Starting dynamic subtest: rcs0
[286.104527] Dynamic subtest rcs0: SUCCESS (0.642s)
[286.127449] Starting dynamic subtest: bcs0
[286.741067] Dynamic subtest bcs0: SUCCESS (0.631s)
[286.759161] Starting dynamic subtest: vcs0
[287.367761] Dynamic subtest vcs0: SUCCESS (0.624s)
[287.389791] Starting dynamic subtest: vecs0
[287.998128] Dynamic subtest vecs0: SUCCESS (0.626s)
[287.999223] Subtest busy-idle: SUCCESS (2.537s)
[288.185306] [044/133] (766s left) perf_pmu (busy-start)
[288.290832] Starting subtest: busy-start
[288.293969] Starting dynamic subtest: rcs0
[290.818227] Dynamic subtest rcs0: SUCCESS (2.526s)
[290.840855] Starting dynamic subtest: bcs0
[293.345838] Dynamic subtest bcs0: SUCCESS (2.523s)
[293.369386] Starting dynamic subtest: vcs0
[295.866701] Dynamic subtest vcs0: SUCCESS (2.518s)
[295.889903] Starting dynamic subtest: vecs0
[298.392541] Dynamic subtest vecs0: SUCCESS (2.522s)
[298.396818] Subtest busy-start: SUCCESS (10.104s)
[298.578867] [045/133] (755s left) kms_selftest (drm_dp_mst_helper)
[298.685688] Starting subtest: drm_dp_mst_helper
[298.727745] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[298.805151] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.079s)
[298.824326] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[298.907950] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.094s)
[298.933722] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[299.013357] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.107s)
[299.014317] Subtest drm_dp_mst_helper: SUCCESS (0.337s)
[299.225528] [046/133] (755s left) gem_exec_schedule (pi-userfault)
[299.474889] Starting subtest: pi-userfault
[299.478340] Starting dynamic subtest: rcs0
[299.491641] Dynamic subtest rcs0: SUCCESS (0.014s)
[299.520890] Starting dynamic subtest: bcs0
[299.521751] Dynamic subtest bcs0: SUCCESS (0.009s)
[299.541108] Starting dynamic subtest: vcs0
[299.541900] Dynamic subtest vcs0: SUCCESS (0.009s)
[299.560582] Starting dynamic subtest: vecs0
[299.561539] Dynamic subtest vecs0: SUCCESS (0.010s)
[299.562566] Subtest pi-userfault: SUCCESS (0.057s)
[299.818621] [047/133] (754s left) gem_userptr_blits (input-checking)
[299.932208] Starting subtest: input-checking
[299.934527] Subtest input-checking: SUCCESS (0.000s)
[300.162717] [048/133] (754s left) kms_psr (fbc-pr-primary-page-flip)
[300.342490] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[300.447171] [049/133] (754s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[300.631149] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[300.748550] [050/133] (754s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[300.960736] Starting subtest: y-tiled-8bpp-rotate-270
[301.276617] Subtest y-tiled-8bpp-rotate-270: SKIP (0.315s)
[301.535091] [051/133] (753s left) kms_psr (pr-primary-page-flip)
[301.729167] Subtest pr-primary-page-flip: SKIP (0.000s)
[301.844217] [052/133] (753s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[302.038369] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[304.467802] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.430s)
[304.703551] [053/133] (750s left) syncobj_wait (multi-wait-submitted-signaled)
[304.807229] Starting subtest: multi-wait-submitted-signaled
[304.808131] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[304.996426] [054/133] (750s left) gem_flink_basic (basic)
[305.095385] Starting subtest: basic
[305.096956] Subtest basic: SUCCESS (0.000s)
[305.254174] [055/133] (750s left) kms_invalid_mode (zero-clock)
[305.434457] Starting subtest: zero-clock
[305.435334] Starting dynamic subtest: pipe-A-HDMI-A-1
[305.847831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.418s)
[305.889403] Starting dynamic subtest: pipe-A-HDMI-A-2
[305.890297] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s)
[305.933049] Starting dynamic subtest: pipe-B-HDMI-A-1
[305.934496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[305.980523] Starting dynamic subtest: pipe-B-HDMI-A-2
[305.982525] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s)
[306.002507] Starting dynamic subtest: pipe-C-HDMI-A-1
[306.003404] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s)
[306.023600] Starting dynamic subtest: pipe-C-HDMI-A-2
[306.024466] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s)
[306.025276] Subtest zero-clock: SUCCESS (0.460s)
[306.197644] [056/133] (749s left) sysfs_preempt_timeout (idempotent)
[306.317860] Starting subtest: idempotent
[306.320714] Starting dynamic subtest: vecs0
[306.321587] Dynamic subtest vecs0: SUCCESS (0.003s)
[306.357948] Starting dynamic subtest: vcs0
[306.360263] Dynamic subtest vcs0: SUCCESS (0.020s)
[306.379833] Starting dynamic subtest: bcs0
[306.380930] Dynamic subtest bcs0: SUCCESS (0.002s)
[306.400232] Starting dynamic subtest: rcs0
[306.401055] Dynamic subtest rcs0: SUCCESS (0.002s)
[306.401831] Subtest idempotent: SUCCESS (0.044s)
[306.536167] [057/133] (749s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[306.724883] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[306.945281] Starting dynamic subtest: pipe-A-plane-0
[307.640490] Dynamic subtest pipe-A-plane-0: SUCCESS (0.698s)
[307.664740] Starting dynamic subtest: pipe-A-plane-1
[308.309593] Dynamic subtest pipe-A-plane-1: SUCCESS (0.663s)
[308.329776] Starting dynamic subtest: pipe-A-plane-2
[308.808828] Dynamic subtest pipe-A-plane-2: SUCCESS (0.496s)
[308.844596] Starting dynamic subtest: pipe-A-plane-3
[309.289761] Dynamic subtest pipe-A-plane-3: SUCCESS (0.478s)
[309.690188] Starting dynamic subtest: pipe-B-plane-0
[310.320264] Dynamic subtest pipe-B-plane-0: SUCCESS (0.648s)
[310.340452] Starting dynamic subtest: pipe-B-plane-1
[310.969787] Dynamic subtest pipe-B-plane-1: SUCCESS (0.646s)
[310.994804] Starting dynamic subtest: pipe-B-plane-2
[311.470968] Dynamic subtest pipe-B-plane-2: SUCCESS (0.497s)
[311.493855] Starting dynamic subtest: pipe-B-plane-3
[311.951463] Dynamic subtest pipe-B-plane-3: SUCCESS (0.479s)
[312.186651] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.463s)
[312.519788] [058/133] (743s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[312.715663] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[312.720904] Starting dynamic subtest: A-HDMI-A1
[314.117951] Dynamic subtest A-HDMI-A1: SUCCESS (1.393s)
[314.140473] Starting dynamic subtest: B-HDMI-A1
[315.045388] Dynamic subtest B-HDMI-A1: SUCCESS (0.923s)
[315.069717] Starting dynamic subtest: C-HDMI-A1
[315.980857] Dynamic subtest C-HDMI-A1: SUCCESS (0.932s)
[316.006863] Starting dynamic subtest: A-HDMI-A2
[316.951719] Dynamic subtest A-HDMI-A2: SUCCESS (0.963s)
[316.981129] Starting dynamic subtest: B-HDMI-A2
[317.904466] Dynamic subtest B-HDMI-A2: SUCCESS (0.944s)
[317.949685] Starting dynamic subtest: C-HDMI-A2
[318.840050] Dynamic subtest C-HDMI-A2: SUCCESS (0.905s)
[318.840918] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.119s)
[319.155478] [059/133] (736s left) gem_basic (bad-close)
[319.267345] Starting subtest: bad-close
[319.268988] Subtest bad-close: SUCCESS (0.000s)
[319.437234] [060/133] (736s left) kms_chamelium_color (ctm-0-75)
[319.610693] Subtest ctm-0-75: SKIP (0.000s)
[319.714062] [061/133] (736s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[319.908898] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[319.911077] Starting dynamic subtest: pipe-A
[324.201884] Dynamic subtest pipe-A: SKIP (4.293s)
[324.221716] Starting dynamic subtest: pipe-B
[328.408163] Dynamic subtest pipe-B: SKIP (4.207s)
[328.445382] Starting dynamic subtest: pipe-C
[332.686820] Dynamic subtest pipe-C: SKIP (4.276s)
[332.691257] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (12.785s)
[333.202360] [062/133] (722s left) kms_psr (psr2-no-drrs)
[333.454765] Subtest psr2-no-drrs: SKIP (0.000s)
[333.562387] [063/133] (722s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[333.669683] Starting subtest: single-wait-for-submit-available-submitted
[333.670733] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[333.835981] [064/133] (722s left) kms_big_fb (x-tiled-addfb)
[334.044286] Starting subtest: x-tiled-addfb
[334.045291] Subtest x-tiled-addfb: SUCCESS (0.001s)
[334.217309] [065/133] (722s left) gem_exec_reloc (basic-range-active)
[334.333958] Starting subtest: basic-range-active
[334.421644] Subtest basic-range-active: SUCCESS (0.087s)
[334.702040] [066/133] (721s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[334.889871] Starting subtest: bad-pixel-format-y-tiled-ccs
[334.891088] Starting dynamic subtest: pipe-A-HDMI-A-1
[334.904273] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[334.993167] Starting dynamic subtest: pipe-A-HDMI-A-2
[335.030350] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.001s)
[335.049690] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.056117] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[335.075640] Starting dynamic subtest: pipe-B-HDMI-A-2
[335.082168] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.001s)
[335.101410] Starting dynamic subtest: pipe-C-HDMI-A-1
[335.108995] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[335.128390] Starting dynamic subtest: pipe-C-HDMI-A-2
[335.135633] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s)
[335.136450] Subtest bad-pixel-format-y-tiled-ccs: SUCCESS (0.036s)
[335.882994] [067/133] (720s left) syncobj_timeline (reset-during-wait-for-submit)
[335.993834] Starting subtest: reset-during-wait-for-submit
[336.098734] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[336.267980] [068/133] (720s left) api_intel_bb (blit-reloc-purge-cache)
[336.373563] Starting subtest: blit-reloc-purge-cache
[336.394138] Subtest blit-reloc-purge-cache: SUCCESS (0.021s)
[336.582487] [069/133] (720s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[336.769236] Starting subtest: cursorA-vs-flipB-varying-size
[348.139662] Subtest cursorA-vs-flipB-varying-size: SUCCESS (11.370s)
[348.448747] [070/133] (708s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[348.655270] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[348.657406] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[348.814071] [071/133] (708s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[349.003214] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[349.109595] [072/133] (707s left) dmabuf_sync_file (import-multiple-read-only)
[349.229673] Starting subtest: import-multiple-read-only
[349.247418] Subtest import-multiple-read-only: SUCCESS (0.016s)
[349.414183] [073/133] (707s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[349.608603] Starting subtest: cursorA-vs-flipA-legacy
[360.913716] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.298s)
[361.236225] [074/133] (695s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[361.441712] Starting subtest: 2x-plain-flip-ts-check-interruptible
[361.442647] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2
[372.489812] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (11.044s)
[372.516887] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2
[383.469418] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.971s)
[383.497455] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2
[394.430416] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.949s)
[394.431563] Subtest 2x-plain-flip-ts-check-interruptible: SUCCESS (32.993s)
[395.067998] [075/133] (662s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[395.283849] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[395.514395] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.228s)
[395.832626] [076/133] (661s left) api_intel_bb (object-reloc-purge-cache)
[395.935741] Starting subtest: object-reloc-purge-cache
[395.948272] Subtest object-reloc-purge-cache: SUCCESS (0.012s)
[396.119273] [077/133] (661s left) syncobj_basic (bad-destroy-pad)
[396.221165] Starting subtest: bad-destroy-pad
[396.224071] Subtest bad-destroy-pad: SUCCESS (0.000s)
[396.404045] [078/133] (661s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[396.514672] Starting subtest: invalid-bsd1-flag-on-vebox
[396.515884] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.001s)
[396.685360] [079/133] (661s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[396.789889] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[396.907629] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.111s)
[397.081767] [080/133] (660s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[397.186508] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[397.299124] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[397.479948] [081/133] (660s left) i915_power (sanity)
[397.583474] Starting subtest: sanity
[401.602705] Subtest sanity: SUCCESS (4.022s)
[401.785188] [082/133] (656s left) syncobj_basic (bad-flags-fd-to-handle)
[401.885541] Starting subtest: bad-flags-fd-to-handle
[401.886590] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[402.049953] [083/133] (656s left) kms_cursor_crc (cursor-offscreen-64x64)
[402.233504] Starting subtest: cursor-offscreen-64x64
[402.279075] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.148705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.870s)
[405.261769] Starting dynamic subtest: pipe-C-HDMI-A-1
[407.740836] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.525s)
[407.742156] Subtest cursor-offscreen-64x64: SUCCESS (5.502s)
[408.071485] [084/133] (650s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[408.269497] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[408.271222] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[408.453965] [085/133] (649s left) gem_exec_fence (invalid-timeline-fence-array)
[409.109026] Starting subtest: invalid-timeline-fence-array
[409.122316] Subtest invalid-timeline-fence-array: SUCCESS (0.012s)
[409.422705] [086/133] (648s left) gem_exec_balancer (bonded-sync)
[409.548295] Starting subtest: bonded-sync
[413.813816] Subtest bonded-sync: SUCCESS (4.267s)
[414.104384] [087/133] (644s left) gem_workarounds (suspend-resume-fd)
[414.238213] Starting subtest: suspend-resume-fd
[431.029658] Subtest suspend-resume-fd: SUCCESS (1.928s)
[445.146262] [088/133] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[445.363904] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[445.367285] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[445.554001] [089/133] (627s left) kms_hdr (invalid-metadata-sizes)
[445.735600] Starting subtest: invalid-metadata-sizes
[445.740422] Subtest invalid-metadata-sizes: SKIP (0.001s)
[445.905958] [090/133] (626s left) gem_softpin (evict-snoop)
[446.021352] Starting subtest: evict-snoop
[446.024959] Subtest evict-snoop: SKIP (0.000s)
[446.189118] [091/133] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[446.382056] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[449.119562] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SUCCESS (2.737s)
[449.356633] [092/133] (623s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[452.003628] Starting subtest: verify-pxp-stale-buf-optout-execution
[452.008551] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.001s)
[452.163143] [093/133] (620s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[452.366028] Starting subtest: cursor-vs-flip-toggle
[497.554311] Subtest cursor-vs-flip-toggle: SUCCESS (45.188s)
[497.872233] [094/133] (575s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[498.071045] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[498.074501] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[498.238301] [095/133] (575s left) gem_userptr_blits (invalid-null-pointer)
[498.354783] Starting subtest: invalid-null-pointer
[498.360175] Subtest invalid-null-pointer: SUCCESS (0.006s)
[498.595253] [096/133] (574s left) kms_cursor_crc (cursor-random-32x10)
[498.786105] Starting subtest: cursor-random-32x10
[498.943593] Subtest cursor-random-32x10: SKIP (0.157s)
[499.140782] [097/133] (574s left) syncobj_wait (single-wait-for-submit-signaled)
[499.252360] Starting subtest: single-wait-for-submit-signaled
[499.254362] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[499.440772] [098/133] (574s left) gem_exec_whisper (basic-fds-priority-all)
[499.575033] Starting subtest: basic-fds-priority-all
[516.790052] Subtest basic-fds-priority-all: SUCCESS (17.212s)
[517.078288] [099/133] (556s left) gem_exec_flush (basic-uc-set-default)
[517.197113] Starting subtest: basic-uc-set-default
[522.608892] Subtest basic-uc-set-default: SUCCESS (5.413s)
[522.915107] [100/133] (550s left) gem_eio (in-flight-contexts-immediate)
[523.052175] Starting subtest: in-flight-contexts-immediate
[534.364257] Subtest in-flight-contexts-immediate: SUCCESS (11.300s)
[534.606901] [101/133] (539s left) kms_vrr (flip-basic-fastset)
[534.790053] Starting subtest: flip-basic-fastset
[534.795076] Subtest flip-basic-fastset: SKIP (0.000s)
[534.956643] [102/133] (539s left) kms_addfb_basic (small-bo)
[535.141778] Starting subtest: small-bo
[535.142611] Subtest small-bo: SUCCESS (0.000s)
[535.323035] [103/133] (538s left) kms_content_protection (atomic-dpms-hdcp14)
[535.513239] Starting subtest: atomic-dpms-hdcp14
[535.561642] Subtest atomic-dpms-hdcp14: SKIP (0.043s)
[535.723510] [104/133] (538s left) gem_exec_suspend (basic-s3)
[535.849802] Starting subtest: basic-S3
[535.850780] Starting dynamic subtest: smem