[56.943560] Initializing watchdogs
[56.943604]   /dev/watchdog0
[56.957384] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.961180] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.963117] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.966202] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[57.135832] Starting subtest: dp-mst-lic-type-0-hdcp14
[57.140782] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[57.250069] [002/133] (960s left) core_getversion (all-cards)
[57.291409] Starting subtest: all-cards
[57.298175] Subtest all-cards: SUCCESS (0.008s)
[57.337496] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[57.425150] Starting subtest: legacy-dpms
[57.427577] Starting dynamic subtest: pipe-A-eDP-1
[64.818841] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.394s)
[64.821194] Subtest legacy-dpms: SUCCESS (7.395s)
[65.660576] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[65.736249] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[65.749618] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[65.815902] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[65.890956] Starting subtest: plane-primary-toggle-with-vblank-wait
[65.893229] Starting dynamic subtest: pipe-A-eDP-1
[66.064692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[66.375369] Starting dynamic subtest: pipe-B-eDP-1
[67.259661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.893s)
[67.556472] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.664s)
[68.417222] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[68.499638] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[68.504153] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[68.609545] [007/133] (949s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[68.690050] Starting subtest: fbc-psr2-primary-mmap-cpu
[68.692366] Starting dynamic subtest: eDP-1
[68.696667] Dynamic subtest eDP-1: SKIP (0.000s)
[68.701012] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[68.802810] [008/133] (948s left) perf (invalid-oa-exponent)
[68.937148] Starting subtest: invalid-oa-exponent
[68.955274] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[68.996356] [009/133] (948s left) gem_eio (create-ext)
[69.145479] Starting subtest: create-ext
[69.320378] Subtest create-ext: SUCCESS (0.176s)
[69.487148] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[69.566151] Starting subtest: invalid-degamma-lut-sizes
[69.568160] Starting dynamic subtest: pipe-A
[69.852332] Dynamic subtest pipe-A: SUCCESS (0.285s)
[69.861344] Starting dynamic subtest: pipe-B
[69.863572] Dynamic subtest pipe-B: SUCCESS (0.000s)
[69.870661] Starting dynamic subtest: pipe-C
[69.872919] Dynamic subtest pipe-C: SUCCESS (0.000s)
[69.880071] Starting dynamic subtest: pipe-D
[69.882310] Dynamic subtest pipe-D: SUCCESS (0.000s)
[69.884527] Subtest invalid-degamma-lut-sizes: SUCCESS (0.287s)
[70.651744] [011/133] (947s left) gem_softpin (allocator-basic)
[70.712675] Starting subtest: allocator-basic
[70.781640] Subtest allocator-basic: SUCCESS (0.068s)
[70.958440] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[71.045580] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[71.047858] Starting dynamic subtest: pipe-A-eDP-1
[76.938766] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.897s)
[76.947883] Starting dynamic subtest: pipe-B-eDP-1
[83.571889] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.630s)
[83.574397] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.529s)
[84.475710] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[84.580453] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[84.584510] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[84.692144] [014/133] (933s left) kms_psr (pr-primary-render)
[84.770060] Starting subtest: pr-primary-render
[84.774337] Subtest pr-primary-render: SKIP (0.000s)
[84.850942] [015/133] (933s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[84.936116] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[84.940591] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[85.049230] [016/133] (933s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[85.142445] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[85.146635] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[85.220686] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[85.276110] Starting subtest: ctrl-surf-copy
[85.280800] Subtest ctrl-surf-copy: SKIP (0.000s)
[85.383595] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[85.485628] Starting subtest: invalid-oa-metric-set-id
[85.494947] Subtest invalid-oa-metric-set-id: SUCCESS (0.008s)
[85.533364] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[85.620729] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[85.624309] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[85.735730] [020/133] (932s left) gem_pxp (create-regular-buffer)
[85.849937] Starting subtest: create-regular-buffer
[85.852233] Subtest create-regular-buffer: SUCCESS (0.000s)
[85.964177] [021/133] (932s left) gem_eio (in-flight-contexts-10ms)
[86.155202] Starting subtest: in-flight-contexts-10ms
[97.838445] Subtest in-flight-contexts-10ms: SUCCESS (11.680s)
[98.014313] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[98.109576] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[104.864069] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.759s)
[105.019621] [023/133] (913s left) gem_exec_schedule (u-fairslice-all)
[105.090961] Starting subtest: u-fairslice-all
[107.159942] Subtest u-fairslice-all: SUCCESS (2.065s)
[107.462503] [024/133] (910s left) core_getstats (basic)
[107.518955] Starting subtest: basic
[107.520947] Subtest basic: SUCCESS (0.000s)
[107.629453] [025/133] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[107.709805] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[107.712070] Starting dynamic subtest: pipe-A-eDP-1
[108.556989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[108.566820] Starting dynamic subtest: pipe-B-eDP-1
[110.079316] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.518s)
[110.088802] Starting dynamic subtest: pipe-C-eDP-1
[111.589820] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.510s)
[111.599563] Starting dynamic subtest: pipe-D-eDP-1
[113.136926] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.539s)
[113.138809] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.411s)
[114.308539] [026/133] (904s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[114.395146] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[114.397645] Starting dynamic subtest: pipe-A-eDP-1
[114.420971] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[114.429820] Starting dynamic subtest: pipe-B-eDP-1
[114.451260] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[114.459058] Starting dynamic subtest: pipe-C-eDP-1
[114.480527] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[114.488557] Starting dynamic subtest: pipe-D-eDP-1
[114.510151] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[114.514160] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[116.569756] [027/133] (901s left) sw_sync (alloc_fence)
[116.602166] Starting subtest: alloc_fence
[116.604461] Subtest alloc_fence: SUCCESS (0.000s)
[116.669282] [028/133] (901s left) i915_pm_rps (basic-api)
[116.737958] Starting subtest: basic-api
[116.742249] Subtest basic-api: SKIP (0.001s)
[116.870333] [029/133] (901s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[116.979388] Starting subtest: cursorB-vs-flipA-toggle
[116.983999] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[117.134410] [030/133] (901s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[117.346774] Starting subtest: cursor-rapid-movement-128x42
[117.393327] Subtest cursor-rapid-movement-128x42: SKIP (0.040s)
[117.621711] [031/133] (901s left) kms_dp_link_training (non-uhbr-sst)
[117.697160] Starting subtest: non-uhbr-sst
[117.704236] Subtest non-uhbr-sst: SKIP (0.000s)
[117.780320] [032/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[117.868423] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[117.871926] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.035401] [033/133] (900s left) gem_exec_parallel (engines)
[118.105064] Starting subtest: engines
[118.107156] Starting dynamic subtest: basic
[119.603995] Dynamic subtest basic: SUCCESS (1.498s)
[119.616150] Starting dynamic subtest: contexts
[125.189865] Dynamic subtest contexts: SUCCESS (5.582s)
[125.201756] Starting dynamic subtest: fds
[129.088058] Dynamic subtest fds: SUCCESS (3.897s)
[129.098654] Starting dynamic subtest: userptr
[130.881672] Dynamic subtest userptr: SUCCESS (1.793s)
[130.884216] Subtest engines: SUCCESS (12.776s)
[131.084870] [034/133] (887s left) gem_eio (in-flight-immediate)
[131.346938] Starting subtest: in-flight-immediate
[139.833195] Subtest in-flight-immediate: SUCCESS (8.486s)
[139.995280] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[139.998354] [035/133] (878s left) prime_mmap (test_forked)
[140.065999] Starting subtest: test_forked
[140.067867] Starting dynamic subtest: test_forked-smem
[140.127733] Dynamic subtest test_forked-smem: SUCCESS (0.062s)
[140.130129] Subtest test_forked: SUCCESS (0.063s)
[140.241136] [036/133] (878s left) kms_dsc (dsc-with-formats)
[140.314241] Starting subtest: dsc-with-formats
[140.352811] Subtest dsc-with-formats: SKIP (0.001s)
[140.400735] [037/133] (878s left) prime_busy (hang)
[140.447735] Starting subtest: hang
[140.450113] Starting dynamic subtest: rcs0
[166.392073] Dynamic subtest rcs0: SUCCESS (25.940s)
[166.403083] Starting dynamic subtest: bcs0
[173.484545] Dynamic subtest bcs0: SUCCESS (7.089s)
[173.494743] Starting dynamic subtest: vcs0
[180.520946] Dynamic subtest vcs0: SUCCESS (7.036s)
[180.529235] Starting dynamic subtest: vcs1
[187.496111] Dynamic subtest vcs1: SUCCESS (6.977s)
[187.504887] Starting dynamic subtest: vecs0
[194.531885] Dynamic subtest vecs0: SUCCESS (7.033s)
[194.539751] Starting dynamic subtest: ccs0
[208.372902] Dynamic subtest ccs0: SUCCESS (13.840s)
[208.374863] Subtest hang: SUCCESS (67.919s)
[208.519281] [038/133] (810s left) kms_vblank (wait-idle)
[208.611624] Starting subtest: wait-idle
[208.613734] Starting dynamic subtest: pipe-A-eDP-1
[210.365971] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[210.380351] Starting dynamic subtest: pipe-D-eDP-1
[212.787126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.418s)
[212.789559] Subtest wait-idle: SUCCESS (4.174s)
[213.616416] [039/133] (805s left) kms_pm_rpm (package-g7)
[215.125093] Starting subtest: package-g7
[215.130148] Subtest package-g7: SKIP (0.000s)
[215.854931] [040/133] (803s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[215.966392] Starting subtest: flip-vs-cursor-varying-size
[224.415197] Subtest flip-vs-cursor-varying-size: SUCCESS (8.447s)
[225.272198] [041/133] (793s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[225.361729] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[232.633085] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.276s)
[232.782113] [042/133] (786s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[232.830536] Starting subtest: single-wait-all-for-submit-signaled
[232.832794] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[232.940704] [043/133] (786s left) perf (gen12-group-exclusive-stream-ctx-handle)
[233.032060] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[233.055266] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[233.110274] [044/133] (786s left) gem_wait (busy)
[234.818920] Starting subtest: busy
[234.821240] Starting dynamic subtest: all-engines
[236.825633] Dynamic subtest all-engines: SUCCESS (2.004s)
[236.837721] Starting dynamic subtest: rcs0
[237.369848] Dynamic subtest rcs0: SUCCESS (0.543s)
[237.380208] Starting dynamic subtest: bcs0
[237.912546] Dynamic subtest bcs0: SUCCESS (0.542s)
[237.923580] Starting dynamic subtest: vcs0
[239.833957] Dynamic subtest vcs0: SUCCESS (1.916s)
[239.845671] Starting dynamic subtest: vcs1
[241.881661] Dynamic subtest vcs1: SUCCESS (2.046s)
[241.893686] Starting dynamic subtest: vecs0
[243.864486] Dynamic subtest vecs0: SUCCESS (1.981s)
[243.875633] Starting dynamic subtest: ccs0
[244.406726] Dynamic subtest ccs0: SUCCESS (0.542s)
[244.409242] Subtest busy: SUCCESS (9.588s)
[244.613136] [045/133] (774s left) gen9_exec_parse (bb-secure)
[244.671576] Subtest bb-secure: SKIP (0.000s)
[244.732626] [046/133] (774s left) kms_cursor_edge_walk (128x128-right-edge)
[244.813156] Starting subtest: 128x128-right-edge
[244.815406] Starting dynamic subtest: pipe-A-eDP-1
[248.254548] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[248.263679] Starting dynamic subtest: pipe-D-eDP-1
[251.373929] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[251.376264] Subtest 128x128-right-edge: SUCCESS (6.561s)
[252.195526] [047/133] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[252.270293] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[252.274554] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.406957] [048/133] (766s left) prime_mmap (test_forked_cpu_write)
[252.449589] Starting subtest: test_forked_cpu_write
[252.451766] Starting dynamic subtest: test_forked_cpu_write-smem
[252.456735] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[252.459024] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[252.584068] [049/133] (766s left) kms_addfb_basic (small-bo)
[252.661838] Starting subtest: small-bo
[252.663687] Subtest small-bo: SUCCESS (0.000s)
[252.782292] [050/133] (766s left) kms_chamelium_audio (dp-audio)
[253.161226] Subtest dp-audio: SKIP (0.000s)
[253.991719] [051/133] (765s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[254.369216] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[255.215680] [052/133] (764s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[255.301244] Starting subtest: psr-shrfb-scaledprimary
[261.139750] Subtest psr-shrfb-scaledprimary: SUCCESS (5.842s)
[261.315436] [053/133] (758s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[261.394657] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[261.399175] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[261.479186] [054/133] (758s left) perf (i915-ref-count)
[261.549101] Starting subtest: i915-ref-count
[261.579808] Subtest i915-ref-count: SUCCESS (0.028s)
[261.635515] [055/133] (757s left) kms_joiner (invalid-modeset-force-big-joiner)
[261.722884] Starting subtest: invalid-modeset-force-big-joiner
[261.727137] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[261.818682] [056/133] (757s left) kms_cursor_crc (cursor-alpha-opaque)
[261.899653] Starting subtest: cursor-alpha-opaque
[261.901933] Starting dynamic subtest: pipe-A-eDP-1
[262.533737] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.632s)
[262.543375] Starting dynamic subtest: pipe-D-eDP-1
[263.835156] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s)
[263.837486] Subtest cursor-alpha-opaque: SUCCESS (1.937s)
[264.644348] [057/133] (755s left) kms_legacy_colorkey (basic)
[264.735016] Starting subtest: basic
[264.736909] Starting dynamic subtest: pipe-A
[264.778638] Dynamic subtest pipe-A: SUCCESS (0.045s)
[264.789900] Starting dynamic subtest: pipe-B
[264.792222] Dynamic subtest pipe-B: SUCCESS (0.001s)
[264.800174] Starting dynamic subtest: pipe-C
[264.802369] Dynamic subtest pipe-C: SUCCESS (0.000s)
[264.810064] Starting dynamic subtest: pipe-D
[264.811899] Dynamic subtest pipe-D: SUCCESS (0.000s)
[264.813770] Subtest basic: SUCCESS (0.050s)
[264.862084] [058/133] (754s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[264.949248] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[264.953136] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[265.068415] [059/133] (754s left) kms_addfb_basic (bad-pitch-32)
[265.116396] Starting subtest: bad-pitch-32
[265.118672] Subtest bad-pitch-32: SUCCESS (0.000s)
[265.239971] [060/133] (754s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[265.294845] Starting subtest: x-tiled-to-vebox-y-tiled
[265.299426] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[265.488045] [061/133] (754s left) gem_exec_reloc (basic-range)
[265.550292] Subtest basic-range: SKIP (0.000s)
[265.649482] [062/133] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[265.726408] Starting subtest: yf-tiled-64bpp-rotate-0
[265.730828] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[265.857902] [063/133] (754s left) syncobj_wait (wait-all-for-submit-snapshot)
[265.911663] Starting subtest: wait-all-for-submit-snapshot
[265.990264] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[266.100463] [064/133] (753s left) kms_async_flips (invalid-async-flip)
[266.173631] Starting subtest: invalid-async-flip
[266.563515] Starting dynamic subtest: pipe-A-eDP-1
[267.358549] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[267.731071] Starting dynamic subtest: pipe-B-eDP-1
[268.507184] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s)
[268.862513] Starting dynamic subtest: pipe-C-eDP-1
[269.622445] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[269.974276] Starting dynamic subtest: pipe-D-eDP-1
[270.751039] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[270.753364] Subtest invalid-async-flip: SUCCESS (4.578s)
[271.917401] [065/133] (748s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[271.996658] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[271.998932] Starting dynamic subtest: A-eDP1
[275.525056] Dynamic subtest A-eDP1: SUCCESS (3.525s)
[275.534781] Starting dynamic subtest: B-eDP1
[278.712207] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[278.720732] Starting dynamic subtest: C-eDP1
[281.808428] Dynamic subtest C-eDP1: SUCCESS (3.095s)
[281.817297] Starting dynamic subtest: D-eDP1
[284.908525] Dynamic subtest D-eDP1: SUCCESS (3.099s)
[284.911082] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.914s)
[285.721863] [066/133] (734s left) kms_frontbuffer_tracking (fbc-suspend)
[285.811298] Starting subtest: fbc-suspend
[324.094763] Subtest fbc-suspend: SUCCESS (8.361s)
[325.300205] [067/133] (694s left) syncobj_timeline (invalid-transfer-bad-pad)
[325.364420] Starting subtest: invalid-transfer-bad-pad
[325.367023] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[325.472047] [068/133] (694s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[325.580780] Starting subtest: 4-tiled-64bpp-rotate-90
[325.598139] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[325.749016] [069/133] (694s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[325.813433] Starting subtest: saturated-hostile-nopreempt
[325.815879] Starting dynamic subtest: rcs0
[325.909831] Dynamic subtest rcs0: SKIP (0.092s)
[325.921375] Starting dynamic subtest: bcs0
[325.928498] Dynamic subtest bcs0: SKIP (0.016s)
[325.937685] Starting dynamic subtest: vcs0
[325.944826] Dynamic subtest vcs0: SKIP (0.016s)
[325.954172] Starting dynamic subtest: vcs1
[325.961321] Dynamic subtest vcs1: SKIP (0.016s)
[325.970576] Starting dynamic subtest: vecs0
[325.975061] Dynamic subtest vecs0: SKIP (0.013s)
[325.983629] Starting dynamic subtest: ccs0
[325.994307] Dynamic subtest ccs0: SKIP (0.019s)
[325.998793] Subtest saturated-hostile-nopreempt: SKIP (0.179s)
[326.081564] [070/133] (694s left) gem_exec_big (single)
[326.146968] Starting subtest: single
[327.140281] Subtest single: SUCCESS (0.994s)
[327.319935] [071/133] (692s left) gem_exec_fence (submit67)
[327.541086] Starting subtest: submit67
[327.545584] Subtest submit67: SKIP (0.000s)
[329.881144] [072/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[329.983576] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[329.988113] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[330.146401] [073/133] (690s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[330.219441] Starting subtest: fbc-rgb101010-draw-mmap-wc
[334.773713] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.555s)
[335.895571] [074/133] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[335.979210] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[335.983363] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[336.114133] [075/133] (684s left) i915_drm_fdinfo (busy-idle)
[336.152229] Starting subtest: busy-idle
[336.154479] Starting dynamic subtest: rcs0
[336.174649] Dynamic subtest rcs0: SKIP (0.022s)
[336.186578] Starting dynamic subtest: bcs0
[336.191533] Dynamic subtest bcs0: SKIP (0.000s)
[336.203732] Starting dynamic subtest: vcs0
[336.207962] Dynamic subtest vcs0: SKIP (0.000s)
[336.216787] Starting dynamic subtest: vcs1
[336.220991] Dynamic subtest vcs1: SKIP (0.000s)
[336.230155] Starting dynamic subtest: vecs0
[336.234520] Dynamic subtest vecs0: SKIP (0.000s)
[336.243524] Starting dynamic subtest: ccs0
[336.247854] Dynamic subtest ccs0: SKIP (0.000s)
[336.252158] Subtest busy-idle: SKIP (0.028s)
[336.288435] [076/133] (684s left) kms_psr (psr2-primary-page-flip)
[336.364928] Starting subtest: psr2-primary-page-flip
[336.367169] Starting dynamic subtest: eDP-1
[338.054978] Dynamic subtest eDP-1: SUCCESS (1.690s)
[338.057301] Subtest psr2-primary-page-flip: SUCCESS (1.691s)
[338.945626] [077/133] (681s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[339.047566] Starting subtest: cursorA-vs-flipB-atomic
[339.052122] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[339.207014] [078/133] (681s left) kms_prop_blob (blob-prop-lifetime)
[339.260809] Starting subtest: blob-prop-lifetime
[339.263102] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[339.383245] [079/133] (681s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[339.458854] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[339.461177] Starting dynamic subtest: pipe-A
[339.625622] Dynamic subtest pipe-A: SKIP (0.162s)
[339.636096] Starting dynamic subtest: pipe-B
[340.794935] Dynamic subtest pipe-B: SKIP (1.168s)
[340.805063] Starting dynamic subtest: pipe-C
[341.939120] Dynamic subtest pipe-C: SUCCESS (1.149s)
[341.949040] Starting dynamic subtest: pipe-D
[343.071533] Dynamic subtest pipe-D: SUCCESS (1.131s)
[343.073840] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.614s)
[344.270695] [080/133] (676s left) kms_pipe_crc_basic (hang-read-crc)
[344.347623] Starting subtest: hang-read-crc
[344.349924] Starting dynamic subtest: pipe-A-eDP-1
[346.434266] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.086s)
[346.446550] Starting dynamic subtest: pipe-B-eDP-1
[349.287165] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.849s)
[349.297801] Starting dynamic subtest: pipe-C-eDP-1
[351.905181] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.615s)
[351.915869] Starting dynamic subtest: pipe-D-eDP-1
[354.577944] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.671s)
[354.580243] Subtest hang-read-crc: SUCCESS (10.228s)
[355.420617] [081/133] (665s left) kms_selftest (drm_format)
[355.476526] Starting subtest: drm_format
[355.486319] Starting dynamic subtest: drm_test_format_block_width_invalid
[355.636918] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.149s)
[355.647363] Starting dynamic subtest: drm_test_format_block_width_one_plane
[355.785779] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.148s)
[355.795463] Starting dynamic subtest: drm_test_format_block_width_two_plane
[355.937687] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.151s)
[355.947021] Starting dynamic subtest: drm_test_format_block_width_three_plane
[356.086794] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.148s)
[356.096279] Starting dynamic subtest: drm_test_format_block_width_tiled
[356.240676] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.153s)
[356.249788] Starting dynamic subtest: drm_test_format_block_height_invalid
[356.379712] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.137s)
[356.390513] Starting dynamic subtest: drm_test_format_block_height_one_plane
[356.527854] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.148s)
[356.538579] Starting dynamic subtest: drm_test_format_block_height_two_plane
[356.659760] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.129s)
[356.670628] Starting dynamic subtest: drm_test_format_block_height_three_plane
[356.789642] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.129s)
[356.798813] Starting dynamic subtest: drm_test_format_block_height_tiled
[356.935094] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.145s)
[356.943917] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[357.076081] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.140s)
[357.084763] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[357.201561] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.125s)
[357.210369] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[357.313368] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.112s)
[357.322334] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[357.423973] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.109s)
[357.433420] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[357.547993] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.122s)
[357.557232] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[357.634511] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.087s)
[357.643476] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[357.749478] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.113s)
[357.758446] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[357.879361] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.129s)
[357.881254] Subtest drm_format: SUCCESS (2.403s)
[358.095796] [082/133] (662s left) gem_close_race (multigpu-basic-process)
[358.172499] Starting subtest: multigpu-basic-process
[358.176879] Subtest multigpu-basic-process: SKIP (0.000s)
[358.438163] [083/133] (662s left) gem_set_tiling_vs_gtt
[358.576410] [084/133] (662s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[358.663009] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[358.665240] Starting dynamic subtest: pipe-A
[358.682134] Dynamic subtest pipe-A: SKIP (0.016s)
[358.692331] Starting dynamic subtest: pipe-B
[358.711795] Dynamic subtest pipe-B: SKIP (0.028s)
[358.721477] Starting dynamic subtest: pipe-C
[358.741114] Dynamic subtest pipe-C: SKIP (0.029s)
[358.750563] Starting dynamic subtest: pipe-D
[358.770868] Dynamic subtest pipe-D: SKIP (0.028s)
[358.775050] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.103s)
[358.896183] [085/133] (662s left) kms_addfb_basic (basic-y-tiled-legacy)
[358.961932] Starting subtest: basic-y-tiled-legacy
[358.966115] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[359.102059] [086/133] (661s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[359.195181] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[360.363380] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.167s)
[360.518098] [087/133] (660s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[360.584309] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[360.588163] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[360.778161] [088/133] (660s left) gem_caching (writes)
[360.845870] Subtest writes: SKIP (0.000s)
[360.934136] [089/133] (660s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[361.000165] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[361.102151] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[361.188952] [090/133] (659s left) kms_flip (wf_vblank-ts-check)
[361.274107] Starting subtest: wf_vblank-ts-check
[361.276134] Starting dynamic subtest: A-eDP1
[370.146908] Dynamic subtest A-eDP1: SUCCESS (8.873s)
[370.157054] Starting dynamic subtest: B-eDP1
[379.081346] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[379.093292] Starting dynamic subtest: C-eDP1
[388.007532] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[388.018619] Starting dynamic subtest: D-eDP1
[396.932505] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[396.934887] Subtest wf_vblank-ts-check: SUCCESS (35.656s)
[398.173219] [091/133] (623s left) gem_lmem_evict (dontneed-evict-race)
[398.223171] Subtest dontneed-evict-race: SKIP (0.000s)
[398.266909] [092/133] (622s left) gem_mmap_gtt (medium-copy-odd)
[398.328717] Subtest medium-copy-odd: SKIP (0.000s)
[398.396126] [093/133] (622s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[398.477348] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[398.490019] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[398.564643] [094/133] (622s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[398.643598] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[398.645855] Starting dynamic subtest: pipe-A-eDP-1
[398.699884] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[398.709015] Starting dynamic subtest: pipe-B-eDP-1
[398.762164] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[398.771875] Starting dynamic subtest: pipe-C-eDP-1
[398.827583] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[398.838027] Starting dynamic subtest: pipe-D-eDP-1
[398.894336] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[398.898584] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[400.921912] [095/133] (620s left) gem_exec_suspend (basic-s0)
[400.991826] Starting subtest: basic-S0
[400.994229] Starting dynamic subtest: smem
[421.487237] Dynamic subtest smem: SUCCESS (6.742s)
[421.490236] Subtest basic-S0: SUCCESS (6.744s)
[421.705902] [096/133] (599s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[421.805631] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[422.797230] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.990s)
[422.940370] [097/133] (598s left) gem_mmap_offset (bad-extensions)
[423.010395] Starting subtest: bad-extensions
[423.012737] Subtest bad-extensions: SUCCESS (0.000s)
[423.135217] [098/133] (598s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[423.242937] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[423.246710] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[423.398256] [099/133] (598s left) gem_mmap_gtt (cpuset-big-copy-odd)
[423.459202] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[423.525168] [100/133] (598s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[423.616392] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[423.620222] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[423.732561] [101/133] (597s left) kms_psr (fbc-psr2-sprite-render)
[423.804346] Starting subtest: fbc-psr2-sprite-render
[423.806197] Starting dynamic subtest: eDP-1
[423.809283] Dynamic subtest eDP-1: SKIP (0.000s)
[423.812703] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[423.884636] [102/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[423.960829] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[423.963907] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[424.085537] [103/133] (597s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[424.159993] Starting subtest: crc-primary-basic-y-tiled-ccs
[424.161904] Starting dynamic subtest: pipe-A-eDP-1
[424.180624] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[424.191576] Starting dynamic subtest: pipe-B-eDP-1
[424.209129] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.218604] Starting dynamic subtest: pipe-C-eDP-1
[424.236227] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.245569] Starting dynamic subtest: pipe-D-eDP-1
[424.263475] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.266765] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[426.445928] [104/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[426.522530] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[426.526898] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[426.652520] [105/133] (595s left) api_intel_bb (add-remove-objects)
[426.721269] Starting subtest: add-remove-objects
[426.727496] Subtest add-remove-objects: SUCCESS (0.009s)
[426.868915] [106/133] (594s left) sysfs_heartbeat_interval (nopreempt)
[426.922333] Starting subtest: nopreempt
[426.924685] Starting dynamic subtest: vecs0
[436.539103] Dynamic subtest vecs0: SUCCESS (9.611s)
[436.553290] Starting dynamic subtest: ccs0
[440.620164] Dynamic subtest ccs0: SUCCESS (4.080s)
[440.632625] Starting dynamic subtest: vcs0
[450.564888] Dynamic subtest vcs0: SUCCESS (9.937s)
[450.577322] Starting dynamic subtest: bcs0
[454.554163] Dynamic subtest bcs0: SUCCESS (3.988s)
[454.567054] Starting dynamic subtest: rcs0
[458.628672] Dynamic subtest rcs0: SUCCESS (4.075s)
[458.644167] Starting dynamic subtest: vcs1
[467.518968] Dynamic subtest vcs1: SUCCESS (8.885s)
[467.521335] Subtest nopreempt: SUCCESS (40.588s)
[467.607344] [107/133] (554s left) kms_getfb (getfb2-into-addfb2)
[467.697257] Starting subtest: getfb2-into-addfb2
[467.699468] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[467.811157] [108/133] (554s left) gem_close (basic)
[467.886064] Starting subtest: basic
[467.887918] Subtest basic: SUCCESS (0.000s)
[468.009190] [109/133] (553s left) gem_exec_schedule (preemptive-hang)
[468.186834] Starting subtest: preemptive-hang
[468.188874] Starting dynamic subtest: rcs0
[477.663127] Dynamic subtest rcs0: SUCCESS (9.475s)
[477.675321] Starting dynamic subtest: bcs0
[486.679784] Dynamic subtest bcs0: SUCCESS (9.017s)
[486.693899] Starting dynamic subtest: vcs0
[495.675702] Dynamic subtest vcs0: SUCCESS (8.992s)
[495.691246] Starting dynamic subtest: vcs1
[504.663446] Dynamic subtest vcs1: SUCCESS (8.985s)
[504.675319] Starting dynamic subtest: vecs0
[513.622177] Dynamic subtest vecs0: SUCCESS (8.953s)
[513.634729] Starting dynamic subtest: ccs0
[522.725895] Dynamic subtest ccs0: SUCCESS (9.103s)
[522.728477] Subtest preemptive-hang: SUCCESS (54.534s)
[523.006382] [110/133] (498s left) i915_drm_fdinfo (virtual-busy-idle)
[523.048219] Starting subtest: virtual-busy-idle
[523.052726] Subtest virtual-busy-idle: SKIP (0.000s)
[523.123667] [111/133] (498s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[523.208102] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[527.214491] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.009s)
[528.358807] [112/133] (493s left) gem_linear_blits (interruptible)
[528.572526] Starting subtest: interruptible
[532.586788] Subtest interruptible: SUCCESS (4.014s)
[532.725471] [113/133] (489s left) gem_ctx_persistence (engines-mixed)
[532.821167] Starting subtest: engines-mixed
[532.823597] Starting dynamic subtest: rcs0
[532.917861] Dynamic subtest rcs0: SUCCESS (0.096s)
[532.930554] Starting dynamic subtest: bcs0
[532.959190] Dynamic subtest bcs0: SUCCESS (0.040s)
[532.969437] Starting dynamic subtest: vcs0
[533.067771] Dynamic subtest vcs0: SUCCESS (0.107s)
[533.079522] Starting dynamic subtest: vcs1
[533.145435] Dynamic subtest vcs1: SUCCESS (0.076s)
[533.157402] Starting dynamic subtest: vecs0
[533.230083] Dynamic subtest vecs0: SUCCESS (0.082s)
[533.246528] Starting dynamic subtest: ccs0
[533.299568] Dynamic subtest ccs0: SUCCESS (0.067s)
[533.302119] Subtest engines-mixed: SUCCESS (0.480s)
[533.408812] [114/133] (488s left) perf_pmu (init-wait)
[533.447618] Starting subtest: init-wait
[533.449953] Starting dynamic subtest: rcs0
[533.452287] Dynamic subtest rcs0: SUCCESS (0.002s)
[533.463105] Starting dynamic subtest: bcs0
[533.464954] Dynamic subtest bcs0: SUCCESS (0.000s)
[533.474159] Starting dynamic subtest: vcs0
[533.476517] Dynamic subtest vcs0: SUCCESS (0.000s)
[533.486278] Starting dynamic subtest: vcs1
[533.488610] Dynamic subtest vcs1: SUCCESS (0.001s)
[533.498277] Starting dynamic subtest: vecs0
[533.500210] Dynamic subtest vecs0: SUCCESS (0.001s)
[533.510190] Starting dynamic subtest: ccs0
[533.512083] Dynamic subtest ccs0: SUCCESS (0.000s)
[533.513975] Subtest init-wait: SUCCESS (0.008s)
[533.559983] [115/133] (488s left) gem_exec_reloc (basic-gtt-cpu-active)
[533.620297] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[533.683338] [116/133] (488s left) kms_pm_lpsp (screens-disabled)
[534.788685] Starting subtest: screens-disabled
[534.792651] Subtest screens-disabled: SKIP (0.000s)
[534.881228] [117/133] (487s left) kms_flip (flip-vs-expired-vblank-interruptible)
[534.962284] Starting subtest: flip-vs-expired-vblank-interruptible
[534.964681] Starting dynamic subtest: A-eDP1
[543.638598] Dynamic subtest A-eDP1: SUCCESS (8.676s)
[543.649773] Starting dynamic subtest: B-eDP1
[552.274526] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[552.286929] Starting dynamic subtest: C-eDP1
[560.890097] Dynamic subtest C-eDP1: SUCCESS (8.612s)
[560.900793] Starting dynamic subtest: D-eDP1
[569.514637] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[569.520597] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.555s)
[570.728726] [118/133] (451s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[570.821769] Starting subtest: psr-1p-primscrn-cur-indfb-move
[578.174795] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.356s)
[578.335609] [119/133] (443s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[578.415673] Starting subtest: plane-all-modeset-transition-internal-panels
[578.417816] Starting dynamic subtest: pipe-A-eDP-1
[579.305527] Dynamic subtest pipe-A-eDP-1: FAIL (0.310s)
[579.316853] Starting dynamic subtest: pipe-B-eDP-1
[579.747904] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.018s)
[580.020377] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.604s)
[580.875770] [120/133] (441s left) gem_userptr_blits (stress-mm)
[580.947881] Starting subtest: stress-mm
[586.319346] Subtest stress-mm: SUCCESS (5.369s)
[586.499603] [121/133] (435s left) syncobj_eventfd (invalid-bad-flags)
[586.567290] Starting subtest: invalid-bad-flags
[586.569273] Subtest invalid-bad-flags: SUCCESS (0.000s)
[586.665284] [122/133] (435s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[586.732983] Starting subtest: framebuffer-vs-set-tiling
[586.737116] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[586.891550] [123/133] (435s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[586.981190] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[586.985086] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[587.102172] [124/133] (435s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[587.159982] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[587.162157] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[587.284542] [125/133] (435s left) kms_flip (2x-modeset-vs-vblank-race)
[587.363587] Starting subtest: 2x-modeset-vs-vblank-race
[587.374233] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[587.523710] [126/133] (435s left) i915_query (query-regions-garbage-items)
[587.587623] Starting subtest: query-regions-garbage-items
[587.589265] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[587.715331] [127/133] (434s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[587.795226] Starting subtest: flip-primary-invalidate-overlay
[599.450704] Subtest flip-primary-invalidate-overlay: SUCCESS (11.654s)
[599.598860] [128/133] (423s left) gem_exec_balancer (full-late)
[599.660786] Starting subtest: full-late
[604.348686] Subtest full-late: SUCCESS (4.686s)
[604.691516] [129/133] (418s left) gem_exec_reloc (basic-write-wc)
[604.759329] Subtest basic-write-wc: SKIP (0.000s)
[604.842611] [130/133] (417s left) kms_force_connector_basic (force-load-detect)
[604.909059] Subtest force-load-detect: SKIP (0.000s)
[604.985313] [131/133] (417s left) kms_chamelium_hpd (hdmi-hpd-fast)
[605.355613] Subtest hdmi-hpd-fast: SKIP (0.000s)
[606.178630] [132/133] (416s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[606.265903] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[606.268252] Starting dynamic subtest: pipe-A-default-mode
[609.053236] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s)
[609.055266] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.786s)
[609.896162] [133/133] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[609.990641] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[609.994952] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[610.128928] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: core_getversion
results: parsing output: 2/ for test: kms_atomic_interruptible
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_eio
results: parsing output: 9/ for test: kms_color
results: parsing output: 10/ for test: gem_softpin
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: gem_ccs
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: core_getstats
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: i915_pm_rps
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: kms_dp_link_training
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_parallel
results: parsing output: 33/ for test: gem_eio
results: parsing output: 34/ for test: prime_mmap
results: parsing output: 35/ for test: kms_dsc
results: parsing output: 36/ for test: prime_busy
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_wait
results: parsing output: 44/ for test: gen9_exec_parse
results: parsing output: 45/ for test: kms_cursor_edge_walk
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: kms_chamelium_audio
results: parsing output: 50/ for test: kms_chamelium_edid
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: perf
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_legacy_colorkey
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_render_copy
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_prop_blob
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_pipe_crc_basic
results: parsing output: 80/ for test: kms_selftest
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: gem_set_tiling_vs_gtt
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_caching
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_lmem_evict
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_suspend
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: sysfs_heartbeat_interval
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_close
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: perf_pmu
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_pm_lpsp
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: i915_query
results: parsing output: 126/ for test: kms_psr_stress_test
results: parsing output: 127/ for test: gem_exec_balancer
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_force_connector_basic
results: parsing output: 130/ for test: kms_chamelium_hpd
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.