[58.878680] Initializing watchdogs
[58.878775]   /dev/watchdog0
[58.894339] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.898762] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.901628] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.906333] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[59.088480] Starting subtest: dp-mst-lic-type-0-hdcp14
[59.092985] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[59.263337] [002/133] (960s left) core_getversion (all-cards)
[59.303625] Starting subtest: all-cards
[59.310459] Subtest all-cards: SUCCESS (0.009s)
[59.348903] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[59.447797] Starting subtest: legacy-dpms
[59.450225] Starting dynamic subtest: pipe-A-eDP-1
[66.851329] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.400s)
[66.853570] Subtest legacy-dpms: SUCCESS (7.401s)
[67.725189] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[67.876903] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[67.890269] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[67.968368] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[68.148056] Starting subtest: plane-primary-toggle-with-vblank-wait
[68.150472] Starting dynamic subtest: pipe-A-eDP-1
[68.320787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[68.624370] Starting dynamic subtest: pipe-B-eDP-1
[69.487060] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.869s)
[69.796126] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.650s)
[70.657724] [006/133] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[70.770540] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[70.774651] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.898635] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[70.992487] Starting subtest: fbc-psr2-primary-mmap-cpu
[70.994625] Starting dynamic subtest: eDP-1
[70.998919] Dynamic subtest eDP-1: SKIP (0.000s)
[71.003386] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[71.072702] [008/133] (948s left) perf (invalid-oa-exponent)
[71.206594] Starting subtest: invalid-oa-exponent
[71.220359] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[71.259566] [009/133] (948s left) gem_eio (create-ext)
[71.405854] Starting subtest: create-ext
[71.583064] Subtest create-ext: SUCCESS (0.177s)
[71.742041] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[71.841851] Starting subtest: invalid-degamma-lut-sizes
[71.843990] Starting dynamic subtest: pipe-A
[72.135530] Dynamic subtest pipe-A: SUCCESS (0.291s)
[72.144492] Starting dynamic subtest: pipe-B
[72.146802] Dynamic subtest pipe-B: SUCCESS (0.000s)
[72.154215] Starting dynamic subtest: pipe-C
[72.156638] Dynamic subtest pipe-C: SUCCESS (0.000s)
[72.163846] Starting dynamic subtest: pipe-D
[72.166190] Dynamic subtest pipe-D: SUCCESS (0.000s)
[72.168070] Subtest invalid-degamma-lut-sizes: SUCCESS (0.293s)
[72.990227] [011/133] (946s left) gem_softpin (allocator-basic)
[73.051055] Starting subtest: allocator-basic
[73.124626] Subtest allocator-basic: SUCCESS (0.073s)
[73.251869] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[73.357140] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[73.359481] Starting dynamic subtest: pipe-A-eDP-1
[79.273299] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.917s)
[79.282804] Starting dynamic subtest: pipe-B-eDP-1
[85.926523] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.652s)
[85.929071] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.571s)
[86.812381] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[86.931279] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[86.935372] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[87.038280] [014/133] (932s left) kms_psr (pr-primary-render)
[87.144700] Starting subtest: pr-primary-render
[87.149081] Subtest pr-primary-render: SKIP (0.000s)
[87.237563] [015/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[87.329829] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[87.334054] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.460715] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[87.571041] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[87.575154] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[87.649498] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[87.713683] Starting subtest: ctrl-surf-copy
[87.718230] Subtest ctrl-surf-copy: SKIP (0.000s)
[87.832387] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[87.935440] Starting subtest: invalid-oa-metric-set-id
[87.945279] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[87.982801] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[88.074831] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[88.078243] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[88.181092] [020/133] (931s left) gem_pxp (create-regular-buffer)
[88.313941] Starting subtest: create-regular-buffer
[88.316289] Subtest create-regular-buffer: SUCCESS (0.000s)
[88.465761] [021/133] (931s left) gem_eio (in-flight-contexts-10ms)
[88.678162] Starting subtest: in-flight-contexts-10ms
[99.954051] Subtest in-flight-contexts-10ms: SUCCESS (11.274s)
[100.149486] [022/133] (920s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[100.253911] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[106.983040] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.732s)
[107.137914] [023/133] (913s left) gem_exec_schedule (u-fairslice-all)
[107.219504] Starting subtest: u-fairslice-all
[109.268442] Subtest u-fairslice-all: SUCCESS (2.055s)
[110.967858] [024/133] (909s left) core_getstats (basic)
[111.028701] Starting subtest: basic
[111.030782] Subtest basic: SUCCESS (0.000s)
[111.162513] [025/133] (909s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[111.274762] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[111.276952] Starting dynamic subtest: pipe-A-eDP-1
[112.135048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[112.144090] Starting dynamic subtest: pipe-B-eDP-1
[113.629411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s)
[113.641653] Starting dynamic subtest: pipe-C-eDP-1
[115.152208] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.520s)
[115.164735] Starting dynamic subtest: pipe-D-eDP-1
[116.665763] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s)
[116.667712] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.383s)
[117.863828] [026/133] (902s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[117.964294] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[117.966566] Starting dynamic subtest: pipe-A-eDP-1
[117.989542] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.000178] Starting dynamic subtest: pipe-B-eDP-1
[118.023878] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.036710] Starting dynamic subtest: pipe-C-eDP-1
[118.059629] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.068677] Starting dynamic subtest: pipe-D-eDP-1
[118.090770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.095169] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[120.138668] [027/133] (900s left) sw_sync (alloc_fence)
[120.182438] Starting subtest: alloc_fence
[120.184589] Subtest alloc_fence: SUCCESS (0.000s)
[120.247998] [028/133] (900s left) i915_pm_rps (basic-api)
[120.323514] Starting subtest: basic-api
[120.327806] Subtest basic-api: SKIP (0.001s)
[120.450997] [029/133] (900s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[120.574895] Starting subtest: cursorB-vs-flipA-toggle
[120.579633] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[120.743917] [030/133] (899s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[120.968078] Starting subtest: cursor-rapid-movement-128x42
[121.020206] Subtest cursor-rapid-movement-128x42: SKIP (0.048s)
[121.262729] [031/133] (899s left) kms_dp_link_training (non-uhbr-sst)
[121.359317] Starting subtest: non-uhbr-sst
[121.366066] Subtest non-uhbr-sst: SKIP (0.000s)
[121.439313] [032/133] (899s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[121.537182] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[121.540531] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[121.662976] [033/133] (898s left) gem_exec_parallel (engines)
[121.740252] Starting subtest: engines
[121.742472] Starting dynamic subtest: basic
[123.864116] Dynamic subtest basic: SUCCESS (2.121s)
[123.875051] Starting dynamic subtest: contexts
[128.342318] Dynamic subtest contexts: SUCCESS (4.476s)
[128.352985] Starting dynamic subtest: fds
[132.153732] Dynamic subtest fds: SUCCESS (3.809s)
[132.165291] Starting dynamic subtest: userptr
[133.652891] Dynamic subtest userptr: SUCCESS (1.499s)
[133.655413] Subtest engines: SUCCESS (11.912s)
[133.861562] [034/133] (886s left) gem_eio (in-flight-immediate)
[134.130247] Starting subtest: in-flight-immediate
[143.096810] Subtest in-flight-immediate: SUCCESS (8.966s)
[143.298007] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[143.301197] [035/133] (877s left) prime_mmap (test_forked)
[143.361672] Starting subtest: test_forked
[143.363993] Starting dynamic subtest: test_forked-smem
[143.415478] Dynamic subtest test_forked-smem: SUCCESS (0.056s)
[143.417929] Subtest test_forked: SUCCESS (0.057s)
[143.529546] [036/133] (877s left) kms_dsc (dsc-with-formats)
[143.617345] Starting subtest: dsc-with-formats
[143.657796] Subtest dsc-with-formats: SKIP (0.001s)
[143.704760] [037/133] (877s left) prime_busy (hang)
[143.772114] Starting subtest: hang
[143.774400] Starting dynamic subtest: rcs0
[170.417775] Dynamic subtest rcs0: SUCCESS (26.642s)
[170.426307] Starting dynamic subtest: bcs0
[177.570676] Dynamic subtest bcs0: SUCCESS (7.151s)
[177.578841] Starting dynamic subtest: vcs0
[184.549052] Dynamic subtest vcs0: SUCCESS (6.980s)
[184.557545] Starting dynamic subtest: vcs1
[191.584095] Dynamic subtest vcs1: SUCCESS (7.034s)
[191.592705] Starting dynamic subtest: vecs0
[198.560390] Dynamic subtest vecs0: SUCCESS (6.975s)
[198.574961] Starting dynamic subtest: ccs0
[212.396835] Dynamic subtest ccs0: SUCCESS (13.833s)
[212.399283] Subtest hang: SUCCESS (68.621s)
[212.533799] [038/133] (808s left) kms_vblank (wait-idle)
[212.639720] Starting subtest: wait-idle
[212.641849] Starting dynamic subtest: pipe-A-eDP-1
[214.405298] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.766s)
[214.421189] Starting dynamic subtest: pipe-D-eDP-1
[216.870681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.460s)
[216.872708] Subtest wait-idle: SUCCESS (4.230s)
[217.699247] [039/133] (803s left) kms_pm_rpm (package-g7)
[219.226885] Starting subtest: package-g7
[219.231715] Subtest package-g7: SKIP (0.000s)
[219.940299] [040/133] (800s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[220.060310] Starting subtest: flip-vs-cursor-varying-size
[228.637725] Subtest flip-vs-cursor-varying-size: SUCCESS (8.577s)
[229.456738] [041/133] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[229.549632] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[236.963322] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.416s)
[237.123116] [042/133] (783s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[237.181577] Starting subtest: single-wait-all-for-submit-signaled
[237.184045] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[237.299057] [043/133] (783s left) perf (gen12-group-exclusive-stream-ctx-handle)
[237.383636] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[237.407229] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[237.473345] [044/133] (783s left) gem_wait (busy)
[238.912859] Starting subtest: busy
[238.915471] Starting dynamic subtest: all-engines
[240.918394] Dynamic subtest all-engines: SUCCESS (2.004s)
[240.930274] Starting dynamic subtest: rcs0
[241.459956] Dynamic subtest rcs0: SUCCESS (0.541s)
[241.471794] Starting dynamic subtest: bcs0
[242.000491] Dynamic subtest bcs0: SUCCESS (0.540s)
[242.010905] Starting dynamic subtest: vcs0
[243.926556] Dynamic subtest vcs0: SUCCESS (1.924s)
[243.937809] Starting dynamic subtest: vcs1
[245.910297] Dynamic subtest vcs1: SUCCESS (1.981s)
[245.921757] Starting dynamic subtest: vecs0
[247.895082] Dynamic subtest vecs0: SUCCESS (1.983s)
[247.906776] Starting dynamic subtest: ccs0
[248.438325] Dynamic subtest ccs0: SUCCESS (0.542s)
[248.440977] Subtest busy: SUCCESS (9.526s)
[248.647131] [045/133] (772s left) gen9_exec_parse (bb-secure)
[248.708365] Subtest bb-secure: SKIP (0.000s)
[248.785082] [046/133] (772s left) kms_cursor_edge_walk (128x128-right-edge)
[248.883945] Starting subtest: 128x128-right-edge
[248.886266] Starting dynamic subtest: pipe-A-eDP-1
[252.296849] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.413s)
[252.305644] Starting dynamic subtest: pipe-D-eDP-1
[255.405100] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[255.407409] Subtest 128x128-right-edge: SUCCESS (6.522s)
[256.249146] [047/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[256.353494] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[256.357883] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[256.485934] [048/133] (764s left) prime_mmap (test_forked_cpu_write)
[256.549325] Starting subtest: test_forked_cpu_write
[256.551360] Starting dynamic subtest: test_forked_cpu_write-smem
[256.556338] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[256.558598] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[256.687438] [049/133] (764s left) kms_addfb_basic (small-bo)
[256.782089] Starting subtest: small-bo
[256.783945] Subtest small-bo: SUCCESS (0.000s)
[256.915151] [050/133] (764s left) kms_chamelium_audio (dp-audio)
[257.303223] Subtest dp-audio: SKIP (0.000s)
[258.136581] [051/133] (763s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.520703] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[259.362421] [052/133] (762s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.458762] Starting subtest: psr-shrfb-scaledprimary
[265.259353] Subtest psr-shrfb-scaledprimary: SUCCESS (5.804s)
[265.432224] [053/133] (756s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[265.528863] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[265.533157] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[265.630521] [054/133] (755s left) perf (i915-ref-count)
[265.721074] Starting subtest: i915-ref-count
[265.748437] Subtest i915-ref-count: SUCCESS (0.024s)
[265.804083] [055/133] (755s left) kms_joiner (invalid-modeset-force-big-joiner)
[265.914507] Starting subtest: invalid-modeset-force-big-joiner
[265.918782] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[265.996176] [056/133] (755s left) kms_cursor_crc (cursor-alpha-opaque)
[266.098113] Starting subtest: cursor-alpha-opaque
[266.100184] Starting dynamic subtest: pipe-A-eDP-1
[266.741410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[266.750264] Starting dynamic subtest: pipe-D-eDP-1
[267.966686] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[267.968724] Subtest cursor-alpha-opaque: SUCCESS (1.868s)
[268.778098] [057/133] (752s left) kms_legacy_colorkey (basic)
[268.881083] Starting subtest: basic
[268.883217] Starting dynamic subtest: pipe-A
[268.924487] Dynamic subtest pipe-A: SUCCESS (0.045s)
[268.935772] Starting dynamic subtest: pipe-B
[268.938139] Dynamic subtest pipe-B: SUCCESS (0.000s)
[268.948479] Starting dynamic subtest: pipe-C
[268.950316] Dynamic subtest pipe-C: SUCCESS (0.000s)
[268.958068] Starting dynamic subtest: pipe-D
[268.959902] Dynamic subtest pipe-D: SUCCESS (0.000s)
[268.961737] Subtest basic: SUCCESS (0.050s)
[269.015677] [058/133] (752s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[269.127112] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[269.131364] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.258100] [059/133] (752s left) kms_addfb_basic (bad-pitch-32)
[269.324562] Starting subtest: bad-pitch-32
[269.326863] Subtest bad-pitch-32: SUCCESS (0.000s)
[269.490549] [060/133] (752s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[269.555551] Starting subtest: x-tiled-to-vebox-y-tiled
[269.560111] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[269.750451] [061/133] (752s left) gem_exec_reloc (basic-range)
[269.825216] Subtest basic-range: SKIP (0.000s)
[269.927614] [062/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[270.022326] Starting subtest: yf-tiled-64bpp-rotate-0
[270.026741] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[270.150492] [063/133] (751s left) syncobj_wait (wait-all-for-submit-snapshot)
[270.211291] Starting subtest: wait-all-for-submit-snapshot
[270.291883] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[270.379435] [064/133] (751s left) kms_async_flips (invalid-async-flip)
[270.473338] Starting subtest: invalid-async-flip
[270.846609] Starting dynamic subtest: pipe-A-eDP-1
[271.667816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s)
[272.041186] Starting dynamic subtest: pipe-B-eDP-1
[272.810220] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[273.167333] Starting dynamic subtest: pipe-C-eDP-1
[273.915830] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.752s)
[274.272964] Starting dynamic subtest: pipe-D-eDP-1
[275.046948] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[275.049706] Subtest invalid-async-flip: SUCCESS (4.577s)
[276.202194] [065/133] (745s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[276.317341] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[276.319649] Starting dynamic subtest: A-eDP1
[279.898844] Dynamic subtest A-eDP1: SUCCESS (3.578s)
[279.907586] Starting dynamic subtest: B-eDP1
[283.098379] Dynamic subtest B-eDP1: SUCCESS (3.199s)
[283.107686] Starting dynamic subtest: C-eDP1
[286.202141] Dynamic subtest C-eDP1: SUCCESS (3.105s)
[286.212718] Starting dynamic subtest: D-eDP1
[289.292560] Dynamic subtest D-eDP1: SUCCESS (3.088s)
[289.294758] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.978s)
[290.109394] [066/133] (731s left) kms_frontbuffer_tracking (fbc-suspend)
[290.211547] Starting subtest: fbc-suspend
[328.618048] Subtest fbc-suspend: SUCCESS (8.319s)
[329.821111] [067/133] (692s left) syncobj_timeline (invalid-transfer-bad-pad)
[329.890814] Starting subtest: invalid-transfer-bad-pad
[329.893378] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[330.007433] [068/133] (692s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[330.119374] Starting subtest: 4-tiled-64bpp-rotate-90
[330.138920] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[330.277183] [069/133] (691s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[330.345076] Starting subtest: saturated-hostile-nopreempt
[330.347433] Starting dynamic subtest: rcs0
[330.444707] Dynamic subtest rcs0: SKIP (0.096s)
[330.455934] Starting dynamic subtest: bcs0
[330.460453] Dynamic subtest bcs0: SKIP (0.013s)
[330.469044] Starting dynamic subtest: vcs0
[330.482344] Dynamic subtest vcs0: SKIP (0.023s)
[330.491098] Starting dynamic subtest: vcs1
[330.499287] Dynamic subtest vcs1: SKIP (0.015s)
[330.507927] Starting dynamic subtest: vecs0
[330.516291] Dynamic subtest vecs0: SKIP (0.016s)
[330.525111] Starting dynamic subtest: ccs0
[330.544298] Dynamic subtest ccs0: SKIP (0.027s)
[330.548877] Subtest saturated-hostile-nopreempt: SKIP (0.198s)
[330.645044] [070/133] (691s left) gem_exec_big (single)
[330.704851] Starting subtest: single
[333.078488] Subtest single: SUCCESS (2.366s)
[333.306622] [071/133] (688s left) gem_exec_fence (submit67)
[333.537837] Starting subtest: submit67
[333.542479] Subtest submit67: SKIP (0.000s)
[335.077928] [072/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[335.195512] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[335.199685] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[335.333597] [073/133] (686s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[335.441427] Starting subtest: fbc-rgb101010-draw-mmap-wc
[340.021755] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.577s)
[341.231006] [074/133] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[341.350179] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[341.354633] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[341.478795] [075/133] (680s left) i915_drm_fdinfo (busy-idle)
[341.524922] Starting subtest: busy-idle
[341.526908] Starting dynamic subtest: rcs0
[341.573084] Dynamic subtest rcs0: SKIP (0.047s)
[341.584000] Starting dynamic subtest: bcs0
[341.588102] Dynamic subtest bcs0: SKIP (0.001s)
[341.597301] Starting dynamic subtest: vcs0
[341.601779] Dynamic subtest vcs0: SKIP (0.001s)
[341.611213] Starting dynamic subtest: vcs1
[341.615325] Dynamic subtest vcs1: SKIP (0.001s)
[341.624459] Starting dynamic subtest: vecs0
[341.628571] Dynamic subtest vecs0: SKIP (0.000s)
[341.637597] Starting dynamic subtest: ccs0
[341.641760] Dynamic subtest ccs0: SKIP (0.000s)
[341.645941] Subtest busy-idle: SKIP (0.058s)
[341.684167] [076/133] (680s left) kms_psr (psr2-primary-page-flip)
[341.783958] Starting subtest: psr2-primary-page-flip
[341.786239] Starting dynamic subtest: eDP-1
[343.502348] Dynamic subtest eDP-1: SUCCESS (1.716s)
[343.504785] Subtest psr2-primary-page-flip: SUCCESS (1.718s)
[344.385162] [077/133] (678s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[344.514541] Starting subtest: cursorA-vs-flipB-atomic
[344.519377] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[344.680339] [078/133] (677s left) kms_prop_blob (blob-prop-lifetime)
[344.740579] Starting subtest: blob-prop-lifetime
[344.743055] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[344.871670] [079/133] (677s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[344.963474] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[344.965880] Starting dynamic subtest: pipe-A
[345.072973] Dynamic subtest pipe-A: SKIP (0.107s)
[345.083259] Starting dynamic subtest: pipe-B
[346.246350] Dynamic subtest pipe-B: SKIP (1.172s)
[346.257200] Starting dynamic subtest: pipe-C
[347.468119] Dynamic subtest pipe-C: SUCCESS (1.224s)
[347.478486] Starting dynamic subtest: pipe-D
[348.615374] Dynamic subtest pipe-D: SUCCESS (1.146s)
[348.617745] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.653s)
[349.818628] [080/133] (672s left) kms_pipe_crc_basic (hang-read-crc)
[349.910974] Starting subtest: hang-read-crc
[349.913348] Starting dynamic subtest: pipe-A-eDP-1
[351.972023] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.060s)
[351.984519] Starting dynamic subtest: pipe-B-eDP-1
[354.647752] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.671s)
[354.658313] Starting dynamic subtest: pipe-C-eDP-1
[357.300685] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.651s)
[357.310869] Starting dynamic subtest: pipe-D-eDP-1
[359.941493] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.637s)
[359.943633] Subtest hang-read-crc: SUCCESS (10.025s)
[360.790422] [081/133] (661s left) kms_selftest (drm_format)
[360.843585] Starting subtest: drm_format
[360.853863] Starting dynamic subtest: drm_test_format_block_width_invalid
[360.971483] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.116s)
[360.980722] Starting dynamic subtest: drm_test_format_block_width_one_plane
[361.080632] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.109s)
[361.089900] Starting dynamic subtest: drm_test_format_block_width_two_plane
[361.196235] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.112s)
[361.207346] Starting dynamic subtest: drm_test_format_block_width_three_plane
[361.301858] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.106s)
[361.312675] Starting dynamic subtest: drm_test_format_block_width_tiled
[361.414202] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.112s)
[361.423206] Starting dynamic subtest: drm_test_format_block_height_invalid
[361.530166] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.115s)
[361.539345] Starting dynamic subtest: drm_test_format_block_height_one_plane
[361.637285] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.105s)
[361.647907] Starting dynamic subtest: drm_test_format_block_height_two_plane
[361.759104] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.121s)
[361.768474] Starting dynamic subtest: drm_test_format_block_height_three_plane
[361.883864] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.122s)
[361.893142] Starting dynamic subtest: drm_test_format_block_height_tiled
[362.001436] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.118s)
[362.010505] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[362.126305] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.124s)
[362.135364] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[362.232861] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.107s)
[362.242179] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[362.357395] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.124s)
[362.366829] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[362.477866] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.117s)
[362.487211] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[362.605153] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.125s)
[362.614887] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[362.712281] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.107s)
[362.722074] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[362.821389] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.110s)
[362.830651] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[362.932975] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.110s)
[362.934829] Subtest drm_format: SUCCESS (2.087s)
[363.166407] [082/133] (659s left) gem_close_race (multigpu-basic-process)
[363.231682] Starting subtest: multigpu-basic-process
[363.235977] Subtest multigpu-basic-process: SKIP (0.000s)
[363.477968] [083/133] (659s left) gem_set_tiling_vs_gtt
[363.621127] [084/133] (659s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[363.715894] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[363.718194] Starting dynamic subtest: pipe-A
[363.735997] Dynamic subtest pipe-A: SKIP (0.017s)
[363.747099] Starting dynamic subtest: pipe-B
[363.769741] Dynamic subtest pipe-B: SKIP (0.030s)
[363.781511] Starting dynamic subtest: pipe-C
[363.799550] Dynamic subtest pipe-C: SKIP (0.031s)
[363.809479] Starting dynamic subtest: pipe-D
[363.829684] Dynamic subtest pipe-D: SKIP (0.030s)
[363.834231] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.111s)
[363.947393] [085/133] (658s left) kms_addfb_basic (basic-y-tiled-legacy)
[364.008613] Starting subtest: basic-y-tiled-legacy
[364.013295] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[364.185467] [086/133] (658s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[364.284170] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[365.434096] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.148s)
[365.615526] [087/133] (657s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[365.676931] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[365.680705] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[365.877440] [088/133] (657s left) gem_caching (writes)
[365.946968] Subtest writes: SKIP (0.000s)
[366.021490] [089/133] (657s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[366.077411] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[366.177740] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[366.268646] [090/133] (656s left) kms_flip (wf_vblank-ts-check)
[366.356949] Starting subtest: wf_vblank-ts-check
[366.362234] Starting dynamic subtest: A-eDP1
[375.326187] Dynamic subtest A-eDP1: SUCCESS (8.964s)
[375.335915] Starting dynamic subtest: B-eDP1
[384.264195] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[384.274907] Starting dynamic subtest: C-eDP1
[393.201423] Dynamic subtest C-eDP1: SUCCESS (8.930s)
[393.211371] Starting dynamic subtest: D-eDP1
[402.140730] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[402.143148] Subtest wf_vblank-ts-check: SUCCESS (35.769s)
[403.377080] [091/133] (619s left) gem_lmem_evict (dontneed-evict-race)
[403.424629] Subtest dontneed-evict-race: SKIP (0.000s)
[403.465456] [092/133] (619s left) gem_mmap_gtt (medium-copy-odd)
[403.525394] Subtest medium-copy-odd: SKIP (0.000s)
[403.584734] [093/133] (619s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[403.687939] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[403.701102] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[403.771757] [094/133] (619s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[403.878142] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[403.880374] Starting dynamic subtest: pipe-A-eDP-1
[403.939109] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[403.950582] Starting dynamic subtest: pipe-B-eDP-1
[404.007495] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[404.018383] Starting dynamic subtest: pipe-C-eDP-1
[404.075222] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[404.085914] Starting dynamic subtest: pipe-D-eDP-1
[404.142698] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[404.147209] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[406.052766] [095/133] (617s left) gem_exec_suspend (basic-s0)
[406.111141] Starting subtest: basic-S0
[406.113595] Starting dynamic subtest: smem
[427.088076] Dynamic subtest smem: SUCCESS (6.893s)
[427.091136] Subtest basic-S0: SUCCESS (6.896s)
[427.286696] [096/133] (596s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[427.397931] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[428.380108] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.978s)
[428.561144] [097/133] (594s left) gem_mmap_offset (bad-extensions)
[428.625822] Starting subtest: bad-extensions
[428.628127] Subtest bad-extensions: SUCCESS (0.000s)
[428.747803] [098/133] (594s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[428.873122] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[428.876800] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[429.018058] [099/133] (594s left) gem_mmap_gtt (cpuset-big-copy-odd)
[429.088742] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[429.170327] [100/133] (594s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[429.274362] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[429.278272] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[429.412626] [101/133] (594s left) kms_psr (fbc-psr2-sprite-render)
[429.512255] Starting subtest: fbc-psr2-sprite-render
[429.514191] Starting dynamic subtest: eDP-1
[429.517719] Dynamic subtest eDP-1: SKIP (0.000s)
[429.521362] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[429.597802] [102/133] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[429.705848] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[429.709224] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[429.813136] [103/133] (593s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[429.919391] Starting subtest: crc-primary-basic-y-tiled-ccs
[429.921271] Starting dynamic subtest: pipe-A-eDP-1
[429.939928] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[429.950943] Starting dynamic subtest: pipe-B-eDP-1
[429.967339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[429.976571] Starting dynamic subtest: pipe-C-eDP-1
[429.993691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[430.002960] Starting dynamic subtest: pipe-D-eDP-1
[430.022046] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[430.025754] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[432.207661] [104/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[432.323380] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[432.327406] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.451762] [105/133] (591s left) api_intel_bb (add-remove-objects)
[432.513718] Starting subtest: add-remove-objects
[432.526171] Subtest add-remove-objects: SUCCESS (0.013s)
[432.689065] [106/133] (591s left) sysfs_heartbeat_interval (nopreempt)
[432.752426] Starting subtest: nopreempt
[432.754691] Starting dynamic subtest: vecs0
[441.058472] Dynamic subtest vecs0: SUCCESS (8.292s)
[441.071130] Starting dynamic subtest: ccs0
[446.943088] Dynamic subtest ccs0: SUCCESS (5.880s)
[446.955845] Starting dynamic subtest: vcs0
[456.097095] Dynamic subtest vcs0: SUCCESS (9.147s)
[456.109936] Starting dynamic subtest: bcs0
[460.087027] Dynamic subtest bcs0: SUCCESS (3.988s)
[460.098981] Starting dynamic subtest: rcs0
[464.087484] Dynamic subtest rcs0: SUCCESS (4.000s)
[464.102130] Starting dynamic subtest: vcs1
[474.060190] Dynamic subtest vcs1: SUCCESS (9.975s)
[474.062772] Subtest nopreempt: SUCCESS (41.295s)
[474.154023] [107/133] (549s left) kms_getfb (getfb2-into-addfb2)
[474.245059] Starting subtest: getfb2-into-addfb2
[474.246950] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[474.379041] [108/133] (549s left) gem_close (basic)
[474.447153] Starting subtest: basic
[474.449561] Subtest basic: SUCCESS (0.000s)
[474.592232] [109/133] (549s left) gem_exec_schedule (preemptive-hang)
[474.774859] Starting subtest: preemptive-hang
[474.777786] Starting dynamic subtest: rcs0
[484.152762] Dynamic subtest rcs0: SUCCESS (9.382s)
[484.162735] Starting dynamic subtest: bcs0
[493.177878] Dynamic subtest bcs0: SUCCESS (9.022s)
[493.187763] Starting dynamic subtest: vcs0
[502.199473] Dynamic subtest vcs0: SUCCESS (9.016s)
[502.211613] Starting dynamic subtest: vcs1
[511.157560] Dynamic subtest vcs1: SUCCESS (8.954s)
[511.169666] Starting dynamic subtest: vecs0
[520.182618] Dynamic subtest vecs0: SUCCESS (9.020s)
[520.192963] Starting dynamic subtest: ccs0
[529.209398] Dynamic subtest ccs0: SUCCESS (9.027s)
[529.211848] Subtest preemptive-hang: SUCCESS (54.430s)
[529.484988] [110/133] (494s left) i915_drm_fdinfo (virtual-busy-idle)
[529.522992] Starting subtest: virtual-busy-idle
[529.527417] Subtest virtual-busy-idle: SKIP (0.000s)
[529.609880] [111/133] (494s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[529.723301] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[533.981812] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.262s)
[535.129055] [112/133] (488s left) gem_linear_blits (interruptible)
[535.359922] Starting subtest: interruptible
[539.744850] Subtest interruptible: SUCCESS (4.385s)
[539.937863] [113/133] (484s left) gem_ctx_persistence (engines-mixed)
[540.047284] Starting subtest: engines-mixed
[540.049746] Starting dynamic subtest: rcs0
[540.173678] Dynamic subtest rcs0: SUCCESS (0.126s)
[540.186118] Starting dynamic subtest: bcs0
[540.251857] Dynamic subtest bcs0: SUCCESS (0.075s)
[540.263753] Starting dynamic subtest: vcs0
[540.341727] Dynamic subtest vcs0: SUCCESS (0.088s)
[540.353837] Starting dynamic subtest: vcs1
[540.423885] Dynamic subtest vcs1: SUCCESS (0.080s)
[540.436376] Starting dynamic subtest: vecs0
[540.510788] Dynamic subtest vecs0: SUCCESS (0.085s)
[540.523430] Starting dynamic subtest: ccs0
[540.590433] Dynamic subtest ccs0: SUCCESS (0.078s)
[540.592877] Subtest engines-mixed: SUCCESS (0.544s)
[540.688535] [114/133] (483s left) perf_pmu (init-wait)
[540.733426] Starting subtest: init-wait
[540.735857] Starting dynamic subtest: rcs0
[540.738160] Dynamic subtest rcs0: SUCCESS (0.002s)
[540.750152] Starting dynamic subtest: bcs0
[540.752166] Dynamic subtest bcs0: SUCCESS (0.000s)
[540.761173] Starting dynamic subtest: vcs0
[540.763028] Dynamic subtest vcs0: SUCCESS (0.001s)
[540.771984] Starting dynamic subtest: vcs1
[540.773591] Dynamic subtest vcs1: SUCCESS (0.001s)
[540.782574] Starting dynamic subtest: vecs0
[540.784389] Dynamic subtest vecs0: SUCCESS (0.000s)
[540.793418] Starting dynamic subtest: ccs0
[540.795188] Dynamic subtest ccs0: SUCCESS (0.000s)
[540.796796] Subtest init-wait: SUCCESS (0.008s)
[540.859798] [115/133] (483s left) gem_exec_reloc (basic-gtt-cpu-active)
[540.927947] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[541.009753] [116/133] (483s left) kms_pm_lpsp (screens-disabled)
[542.116007] Starting subtest: screens-disabled
[542.120320] Subtest screens-disabled: SKIP (0.000s)
[542.199205] [117/133] (482s left) kms_flip (flip-vs-expired-vblank-interruptible)
[542.293955] Starting subtest: flip-vs-expired-vblank-interruptible
[542.296216] Starting dynamic subtest: A-eDP1
[551.012778] Dynamic subtest A-eDP1: SUCCESS (8.717s)
[551.026661] Starting dynamic subtest: B-eDP1
[559.640429] Dynamic subtest B-eDP1: SUCCESS (8.624s)
[559.650426] Starting dynamic subtest: C-eDP1
[568.260426] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[568.276646] Starting dynamic subtest: D-eDP1
[576.887617] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[576.893546] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.598s)
[578.079282] [118/133] (446s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[578.178551] Starting subtest: psr-1p-primscrn-cur-indfb-move
[585.561993] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.385s)
[585.722194] [119/133] (438s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[585.824268] Starting subtest: plane-all-modeset-transition-internal-panels
[585.826377] Starting dynamic subtest: pipe-A-eDP-1
[586.717702] Dynamic subtest pipe-A-eDP-1: FAIL (0.302s)
[586.728422] Starting dynamic subtest: pipe-B-eDP-1
[587.115837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.987s)
[587.388327] Subtest plane-all-modeset-transition-internal-panels: FAIL (1.565s)
[588.235000] [120/133] (436s left) gem_userptr_blits (stress-mm)
[588.306155] Starting subtest: stress-mm
[593.676445] Subtest stress-mm: SUCCESS (5.369s)
[593.845750] [121/133] (430s left) syncobj_eventfd (invalid-bad-flags)
[593.917725] Starting subtest: invalid-bad-flags
[593.920036] Subtest invalid-bad-flags: SUCCESS (0.000s)
[594.061829] [122/133] (430s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[594.125944] Starting subtest: framebuffer-vs-set-tiling
[594.130443] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[594.305442] [123/133] (430s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[594.400720] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[594.404726] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[594.537410] [124/133] (430s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[594.591558] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[594.593929] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[594.722142] [125/133] (429s left) kms_flip (2x-modeset-vs-vblank-race)
[594.817157] Starting subtest: 2x-modeset-vs-vblank-race
[594.828577] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[594.921001] [126/133] (429s left) i915_query (query-regions-garbage-items)
[594.983813] Starting subtest: query-regions-garbage-items
[594.985792] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[595.111516] [127/133] (429s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[595.203963] Starting subtest: flip-primary-invalidate-overlay
[606.832860] Subtest flip-primary-invalidate-overlay: SUCCESS (11.627s)
[607.019995] [128/133] (417s left) gem_exec_balancer (full-late)
[607.072834] Starting subtest: full-late
[611.887986] Subtest full-late: SUCCESS (4.813s)
[612.255281] [129/133] (412s left) gem_exec_reloc (basic-write-wc)
[612.321710] Subtest basic-write-wc: SKIP (0.000s)
[612.393008] [130/133] (412s left) kms_force_connector_basic (force-load-detect)
[612.477266] Starting subtest: force-load-detect
[612.481793] Subtest force-load-detect: SKIP (0.000s)
[612.609748] [131/133] (412s left) kms_chamelium_hpd (hdmi-hpd-fast)
[613.007759] Subtest hdmi-hpd-fast: SKIP (0.000s)
[613.837834] [132/133] (411s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[613.940365] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[613.942847] Starting dynamic subtest: pipe-A-default-mode
[616.675734] Dynamic subtest pipe-A-default-mode: SUCCESS (2.735s)
[616.678109] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.737s)
[617.571100] [133/133] (407s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[617.680621] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[617.684913] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[617.822839] 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.