[59.004361] Initializing watchdogs
[59.004406]   /dev/watchdog0
[59.017957] [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]
[59.022226] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.024494] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.027828] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[59.203463] Starting subtest: dp-mst-lic-type-0-hdcp14
[59.208158] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[59.323747] [002/133] (960s left) core_getversion (all-cards)
[59.364074] Starting subtest: all-cards
[59.371984] Subtest all-cards: SUCCESS (0.010s)
[59.407595] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[59.497776] Starting subtest: legacy-dpms
[59.500086] Starting dynamic subtest: pipe-A-eDP-1
[66.899959] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.403s)
[66.902399] Subtest legacy-dpms: SUCCESS (7.404s)
[67.752985] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[67.867080] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[67.880270] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[68.000022] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[68.112885] Starting subtest: plane-primary-toggle-with-vblank-wait
[68.115129] Starting dynamic subtest: pipe-A-eDP-1
[68.286966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.176s)
[68.604905] Starting dynamic subtest: pipe-B-eDP-1
[69.539877] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.943s)
[69.841079] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.729s)
[70.704140] [006/133] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[70.802779] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[70.807441] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.920159] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[71.009748] Starting subtest: fbc-psr2-primary-mmap-cpu
[71.012078] Starting dynamic subtest: eDP-1
[71.016370] Dynamic subtest eDP-1: SKIP (0.000s)
[71.020709] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[71.091329] [008/133] (948s left) perf (invalid-oa-exponent)
[71.222308] Starting subtest: invalid-oa-exponent
[71.235582] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[71.275584] [009/133] (948s left) gem_eio (create-ext)
[71.419946] Starting subtest: create-ext
[71.638210] Subtest create-ext: SUCCESS (0.216s)
[71.795331] [010/133] (948s left) kms_color (invalid-degamma-lut-sizes)
[71.874358] Starting subtest: invalid-degamma-lut-sizes
[71.876608] Starting dynamic subtest: pipe-A
[72.164031] Dynamic subtest pipe-A: SUCCESS (0.288s)
[72.181892] Starting dynamic subtest: pipe-B
[72.184250] Dynamic subtest pipe-B: SUCCESS (0.000s)
[72.191077] Starting dynamic subtest: pipe-C
[72.193320] Dynamic subtest pipe-C: SUCCESS (0.000s)
[72.200088] Starting dynamic subtest: pipe-D
[72.202280] Dynamic subtest pipe-D: SUCCESS (0.000s)
[72.204414] Subtest invalid-degamma-lut-sizes: SUCCESS (0.291s)
[73.037311] [011/133] (946s left) gem_softpin (allocator-basic)
[73.095890] Starting subtest: allocator-basic
[73.161950] Subtest allocator-basic: SUCCESS (0.066s)
[73.299877] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[73.409347] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[73.411661] Starting dynamic subtest: pipe-A-eDP-1
[79.318857] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.913s)
[79.328402] Starting dynamic subtest: pipe-B-eDP-1
[85.964792] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.645s)
[85.967120] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.560s)
[86.863690] [013/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[86.978981] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[86.983152] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[87.105326] [014/133] (932s left) kms_psr (pr-primary-render)
[87.203967] Starting subtest: pr-primary-render
[87.208418] Subtest pr-primary-render: SKIP (0.000s)
[87.297544] [015/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[87.403797] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[87.408039] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.519830] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[87.635392] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[87.639733] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[87.710743] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[87.779410] Starting subtest: ctrl-surf-copy
[87.783121] Subtest ctrl-surf-copy: SKIP (0.000s)
[87.899869] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[87.994489] Starting subtest: invalid-oa-metric-set-id
[88.002250] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[88.042696] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[88.136933] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[88.140857] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[88.265415] [020/133] (931s left) gem_pxp (create-regular-buffer)
[88.400604] Starting subtest: create-regular-buffer
[88.402743] Subtest create-regular-buffer: SUCCESS (0.000s)
[88.526372] [021/133] (931s left) gem_eio (in-flight-contexts-10ms)
[88.726270] Starting subtest: in-flight-contexts-10ms
[98.933481] Subtest in-flight-contexts-10ms: SUCCESS (10.205s)
[99.063878] [022/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[99.163452] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[105.857275] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.696s)
[105.991808] [023/133] (914s left) gem_exec_schedule (u-fairslice-all)
[106.076486] Starting subtest: u-fairslice-all
[108.126712] Subtest u-fairslice-all: SUCCESS (2.053s)
[108.443089] [024/133] (911s left) core_getstats (basic)
[108.502970] Starting subtest: basic
[108.505061] Subtest basic: SUCCESS (0.000s)
[108.614215] [025/133] (911s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[108.712860] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[108.715099] Starting dynamic subtest: pipe-A-eDP-1
[109.501910] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.784s)
[109.509893] Starting dynamic subtest: pipe-B-eDP-1
[111.069049] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.563s)
[111.077892] Starting dynamic subtest: pipe-C-eDP-1
[112.575029] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s)
[112.584199] Starting dynamic subtest: pipe-D-eDP-1
[114.019946] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.445s)
[114.022494] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.301s)
[115.252739] [026/133] (905s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[115.357894] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[115.360245] Starting dynamic subtest: pipe-A-eDP-1
[115.382740] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.392642] Starting dynamic subtest: pipe-B-eDP-1
[115.414898] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.423895] Starting dynamic subtest: pipe-C-eDP-1
[115.445035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.452130] Starting dynamic subtest: pipe-D-eDP-1
[115.473430] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.477787] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[117.505752] [027/133] (902s left) sw_sync (alloc_fence)
[117.547886] Starting subtest: alloc_fence
[117.550199] Subtest alloc_fence: SUCCESS (0.000s)
[117.622569] [028/133] (902s left) i915_pm_rps (basic-api)
[117.703451] Starting subtest: basic-api
[117.708173] Subtest basic-api: SKIP (0.001s)
[117.792995] [029/133] (902s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[117.917871] Starting subtest: cursorB-vs-flipA-toggle
[117.922437] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[118.083989] [030/133] (902s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[118.299825] Starting subtest: cursor-rapid-movement-128x42
[118.340388] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[118.571502] [031/133] (902s left) kms_dp_link_training (non-uhbr-sst)
[118.661084] Starting subtest: non-uhbr-sst
[118.668114] Subtest non-uhbr-sst: SKIP (0.000s)
[118.743099] [032/133] (901s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.831654] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.835037] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.950847] [033/133] (901s left) gem_exec_parallel (engines)
[119.014531] Starting subtest: engines
[119.016520] Starting dynamic subtest: basic
[120.853808] Dynamic subtest basic: SUCCESS (1.837s)
[120.864115] Starting dynamic subtest: contexts
[125.342670] Dynamic subtest contexts: SUCCESS (4.488s)
[125.350773] Starting dynamic subtest: fds
[129.103307] Dynamic subtest fds: SUCCESS (3.758s)
[129.111873] Starting dynamic subtest: userptr
[130.917923] Dynamic subtest userptr: SUCCESS (1.813s)
[130.920682] Subtest engines: SUCCESS (11.902s)
[131.130913] [034/133] (889s left) gem_eio (in-flight-immediate)
[131.375150] Starting subtest: in-flight-immediate
[140.051071] Subtest in-flight-immediate: SUCCESS (8.674s)
[140.242655] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[140.246013] [035/133] (880s left) prime_mmap (test_forked)
[140.304330] Starting subtest: test_forked
[140.306283] Starting dynamic subtest: test_forked-smem
[140.341369] Dynamic subtest test_forked-smem: SUCCESS (0.039s)
[140.343700] Subtest test_forked: SUCCESS (0.040s)
[140.480542] [036/133] (880s left) kms_dsc (dsc-with-formats)
[140.576870] Starting subtest: dsc-with-formats
[140.616052] Subtest dsc-with-formats: SKIP (0.001s)
[140.659037] [037/133] (880s left) prime_busy (hang)
[140.721701] Starting subtest: hang
[140.724038] Starting dynamic subtest: rcs0
[166.448740] Dynamic subtest rcs0: SUCCESS (25.724s)
[166.458456] Starting dynamic subtest: bcs0
[173.541077] Dynamic subtest bcs0: SUCCESS (7.089s)
[173.550681] Starting dynamic subtest: vcs0
[180.581597] Dynamic subtest vcs0: SUCCESS (7.039s)
[180.591485] Starting dynamic subtest: vcs1
[187.553054] Dynamic subtest vcs1: SUCCESS (6.970s)
[187.560851] Starting dynamic subtest: vecs0
[194.586978] Dynamic subtest vecs0: SUCCESS (7.036s)
[194.594819] Starting dynamic subtest: ccs0
[208.429921] Dynamic subtest ccs0: SUCCESS (13.838s)
[208.432622] Subtest hang: SUCCESS (67.703s)
[208.581427] [038/133] (812s left) kms_vblank (wait-idle)
[208.680360] Starting subtest: wait-idle
[208.682151] Starting dynamic subtest: pipe-A-eDP-1
[210.434754] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.754s)
[210.448878] Starting dynamic subtest: pipe-D-eDP-1
[212.931511] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.493s)
[212.933666] Subtest wait-idle: SUCCESS (4.251s)
[213.764267] [039/133] (807s left) kms_pm_rpm (package-g7)
[216.098780] Starting subtest: package-g7
[216.103334] Subtest package-g7: SKIP (0.000s)
[216.486949] [040/133] (804s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[216.612939] Starting subtest: flip-vs-cursor-varying-size
[225.119164] Subtest flip-vs-cursor-varying-size: SUCCESS (8.504s)
[226.015395] [041/133] (795s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[226.118272] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[233.391418] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.275s)
[233.570761] [042/133] (787s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[233.627805] Starting subtest: single-wait-all-for-submit-signaled
[233.630223] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[233.744885] [043/133] (787s left) perf (gen12-group-exclusive-stream-ctx-handle)
[233.843209] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[233.867895] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[233.905133] [044/133] (787s left) gem_wait (busy)
[235.844680] Starting subtest: busy
[235.847116] Starting dynamic subtest: all-engines
[237.908353] Dynamic subtest all-engines: SUCCESS (2.062s)
[237.919624] Starting dynamic subtest: rcs0
[238.450709] Dynamic subtest rcs0: SUCCESS (0.542s)
[238.461451] Starting dynamic subtest: bcs0
[238.991038] Dynamic subtest bcs0: SUCCESS (0.540s)
[239.001170] Starting dynamic subtest: vcs0
[240.916060] Dynamic subtest vcs0: SUCCESS (1.923s)
[240.926551] Starting dynamic subtest: vcs1
[242.902135] Dynamic subtest vcs1: SUCCESS (1.984s)
[242.913032] Starting dynamic subtest: vecs0
[244.885067] Dynamic subtest vecs0: SUCCESS (1.980s)
[244.895800] Starting dynamic subtest: ccs0
[245.426625] Dynamic subtest ccs0: SUCCESS (0.541s)
[245.429261] Subtest busy: SUCCESS (9.582s)
[245.633641] [045/133] (775s left) gen9_exec_parse (bb-secure)
[245.687793] Subtest bb-secure: SKIP (0.000s)
[245.772131] [046/133] (775s left) kms_cursor_edge_walk (128x128-right-edge)
[245.867868] Starting subtest: 128x128-right-edge
[245.870168] Starting dynamic subtest: pipe-A-eDP-1
[249.380794] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.512s)
[249.391677] Starting dynamic subtest: pipe-D-eDP-1
[252.500791] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[252.502710] Subtest 128x128-right-edge: SUCCESS (6.633s)
[253.320333] [047/133] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[253.424269] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[253.428522] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.553048] [048/133] (767s left) prime_mmap (test_forked_cpu_write)
[253.611603] Starting subtest: test_forked_cpu_write
[253.613859] Starting dynamic subtest: test_forked_cpu_write-smem
[253.619075] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[253.621434] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[253.763106] [049/133] (767s left) kms_addfb_basic (small-bo)
[253.854073] Starting subtest: small-bo
[253.856287] Subtest small-bo: SUCCESS (0.000s)
[253.976962] [050/133] (767s left) kms_chamelium_audio (dp-audio)
[254.374084] Subtest dp-audio: SKIP (0.000s)
[255.216215] [051/133] (766s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[255.608640] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[256.454499] [052/133] (765s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[256.561721] Starting subtest: psr-shrfb-scaledprimary
[262.362204] Subtest psr-shrfb-scaledprimary: SUCCESS (5.804s)
[262.507570] [053/133] (758s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[262.599032] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[262.603140] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[262.680906] [054/133] (758s left) perf (i915-ref-count)
[262.779077] Starting subtest: i915-ref-count
[262.802610] Subtest i915-ref-count: SUCCESS (0.021s)
[262.858816] [055/133] (758s left) kms_joiner (invalid-modeset-force-big-joiner)
[262.955786] Starting subtest: invalid-modeset-force-big-joiner
[262.960133] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[263.029281] [056/133] (758s left) kms_cursor_crc (cursor-alpha-opaque)
[263.121542] Starting subtest: cursor-alpha-opaque
[263.123785] Starting dynamic subtest: pipe-A-eDP-1
[263.729428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[263.737535] Starting dynamic subtest: pipe-D-eDP-1
[264.962574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[264.964480] Subtest cursor-alpha-opaque: SUCCESS (1.842s)
[265.771081] [057/133] (755s left) kms_legacy_colorkey (basic)
[265.863084] Starting subtest: basic
[265.865282] Starting dynamic subtest: pipe-A
[265.908163] Dynamic subtest pipe-A: SUCCESS (0.045s)
[265.919833] Starting dynamic subtest: pipe-B
[265.922547] Dynamic subtest pipe-B: SUCCESS (0.001s)
[265.936309] Starting dynamic subtest: pipe-C
[265.938202] Dynamic subtest pipe-C: SUCCESS (0.000s)
[265.945803] Starting dynamic subtest: pipe-D
[265.947738] Dynamic subtest pipe-D: SUCCESS (0.000s)
[265.949614] Subtest basic: SUCCESS (0.052s)
[265.997501] [058/133] (755s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[266.099839] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[266.104232] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[266.208931] [059/133] (755s left) kms_addfb_basic (bad-pitch-32)
[266.256368] Starting subtest: bad-pitch-32
[266.258232] Subtest bad-pitch-32: SUCCESS (0.000s)
[266.418881] [060/133] (755s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[266.472788] Starting subtest: x-tiled-to-vebox-y-tiled
[266.477322] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[266.667421] [061/133] (755s left) gem_exec_reloc (basic-range)
[266.724848] Subtest basic-range: SKIP (0.000s)
[266.810790] [062/133] (755s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[266.905493] Starting subtest: yf-tiled-64bpp-rotate-0
[266.909819] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[267.006224] [063/133] (754s left) syncobj_wait (wait-all-for-submit-snapshot)
[267.061447] Starting subtest: wait-all-for-submit-snapshot
[267.140378] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[267.229890] [064/133] (754s left) kms_async_flips (invalid-async-flip)
[267.311130] Starting subtest: invalid-async-flip
[267.681343] Starting dynamic subtest: pipe-A-eDP-1
[268.477515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s)
[268.843650] Starting dynamic subtest: pipe-B-eDP-1
[269.623570] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.788s)
[269.976632] Starting dynamic subtest: pipe-C-eDP-1
[270.736775] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.764s)
[271.087684] Starting dynamic subtest: pipe-D-eDP-1
[271.869763] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.787s)
[271.872111] Subtest invalid-async-flip: SUCCESS (4.559s)
[273.042878] [065/133] (748s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[273.141044] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[273.143369] Starting dynamic subtest: A-eDP1
[276.759726] Dynamic subtest A-eDP1: SUCCESS (3.617s)
[276.769051] Starting dynamic subtest: B-eDP1
[279.947687] Dynamic subtest B-eDP1: SUCCESS (3.185s)
[279.956576] Starting dynamic subtest: C-eDP1
[283.041662] Dynamic subtest C-eDP1: SUCCESS (3.091s)
[283.049666] Starting dynamic subtest: D-eDP1
[286.149267] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[286.151129] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.008s)
[286.973973] [066/133] (735s left) kms_frontbuffer_tracking (fbc-suspend)
[287.073076] Starting subtest: fbc-suspend
[324.920348] Subtest fbc-suspend: SUCCESS (7.518s)
[326.121170] [067/133] (695s left) syncobj_timeline (invalid-transfer-bad-pad)
[326.184047] Starting subtest: invalid-transfer-bad-pad
[326.186322] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[326.310149] [068/133] (695s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[326.414633] Starting subtest: 4-tiled-64bpp-rotate-90
[326.434317] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[326.583052] [069/133] (695s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[326.645627] Starting subtest: saturated-hostile-nopreempt
[326.648382] Starting dynamic subtest: rcs0
[326.755327] Dynamic subtest rcs0: SKIP (0.106s)
[326.766683] Starting dynamic subtest: bcs0
[326.780184] Dynamic subtest bcs0: SKIP (0.024s)
[326.788827] Starting dynamic subtest: vcs0
[326.810292] Dynamic subtest vcs0: SKIP (0.028s)
[326.818852] Starting dynamic subtest: vcs1
[326.837099] Dynamic subtest vcs1: SKIP (0.025s)
[326.845441] Starting dynamic subtest: vecs0
[326.859172] Dynamic subtest vecs0: SKIP (0.020s)
[326.867542] Starting dynamic subtest: ccs0
[326.878055] Dynamic subtest ccs0: SKIP (0.017s)
[326.882270] Subtest saturated-hostile-nopreempt: SKIP (0.231s)
[326.977321] [070/133] (695s left) gem_exec_big (single)
[327.037637] Starting subtest: single
[329.368128] Subtest single: SUCCESS (2.329s)
[329.642591] [071/133] (692s left) gem_exec_fence (submit67)
[329.875418] Starting subtest: submit67
[329.880399] Subtest submit67: SKIP (0.000s)
[331.326901] [072/133] (690s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[331.436105] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[331.440240] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[331.563590] [073/133] (690s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[331.676255] Starting subtest: fbc-rgb101010-draw-mmap-wc
[336.285905] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.611s)
[337.412211] [074/133] (684s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[337.517208] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[337.521377] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[337.649776] [075/133] (684s left) i915_drm_fdinfo (busy-idle)
[337.692203] Starting subtest: busy-idle
[337.694336] Starting dynamic subtest: rcs0
[337.741381] Dynamic subtest rcs0: SKIP (0.045s)
[337.752972] Starting dynamic subtest: bcs0
[337.757192] Dynamic subtest bcs0: SKIP (0.000s)
[337.765748] Starting dynamic subtest: vcs0
[337.770114] Dynamic subtest vcs0: SKIP (0.000s)
[337.778824] Starting dynamic subtest: vcs1
[337.783070] Dynamic subtest vcs1: SKIP (0.000s)
[337.791772] Starting dynamic subtest: vecs0
[337.796067] Dynamic subtest vecs0: SKIP (0.000s)
[337.804521] Starting dynamic subtest: ccs0
[337.808848] Dynamic subtest ccs0: SKIP (0.000s)
[337.813179] Subtest busy-idle: SKIP (0.052s)
[337.850871] [076/133] (684s left) kms_psr (psr2-primary-page-flip)
[337.941351] Starting subtest: psr2-primary-page-flip
[337.943554] Starting dynamic subtest: eDP-1
[339.675211] Dynamic subtest eDP-1: SUCCESS (1.732s)
[339.677411] Subtest psr2-primary-page-flip: SUCCESS (1.733s)
[340.482865] [077/133] (681s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[340.606867] Starting subtest: cursorA-vs-flipB-atomic
[340.611305] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[340.759986] [078/133] (681s left) kms_prop_blob (blob-prop-lifetime)
[340.818633] Starting subtest: blob-prop-lifetime
[340.820860] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[340.933713] [079/133] (681s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[341.039701] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[341.041909] Starting dynamic subtest: pipe-A
[341.160356] Dynamic subtest pipe-A: SKIP (0.117s)
[341.170973] Starting dynamic subtest: pipe-B
[342.330986] Dynamic subtest pipe-B: SKIP (1.169s)
[342.340623] Starting dynamic subtest: pipe-C
[343.476559] Dynamic subtest pipe-C: SUCCESS (1.151s)
[343.486397] Starting dynamic subtest: pipe-D
[344.646620] Dynamic subtest pipe-D: SUCCESS (1.169s)
[344.649027] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.610s)
[345.846841] [080/133] (676s left) kms_pipe_crc_basic (hang-read-crc)
[345.926754] Starting subtest: hang-read-crc
[345.929164] Starting dynamic subtest: pipe-A-eDP-1
[348.005696] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.077s)
[348.016443] Starting dynamic subtest: pipe-B-eDP-1
[350.672777] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.669s)
[350.681870] Starting dynamic subtest: pipe-C-eDP-1
[353.304872] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.628s)
[353.314907] Starting dynamic subtest: pipe-D-eDP-1
[355.961669] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.657s)
[355.963976] Subtest hang-read-crc: SUCCESS (10.035s)
[356.817008] [081/133] (665s left) kms_selftest (drm_format)
[356.872856] Starting subtest: drm_format
[356.880877] Starting dynamic subtest: drm_test_format_block_width_invalid
[357.020436] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.137s)
[357.030950] Starting dynamic subtest: drm_test_format_block_width_one_plane
[357.165759] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.144s)
[357.176777] Starting dynamic subtest: drm_test_format_block_width_two_plane
[357.307870] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.140s)
[357.318568] Starting dynamic subtest: drm_test_format_block_width_three_plane
[357.452642] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.145s)
[357.463371] Starting dynamic subtest: drm_test_format_block_width_tiled
[357.563868] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.111s)
[357.572280] Starting dynamic subtest: drm_test_format_block_height_invalid
[357.691915] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.127s)
[357.700250] Starting dynamic subtest: drm_test_format_block_height_one_plane
[357.833942] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.142s)
[357.842375] Starting dynamic subtest: drm_test_format_block_height_two_plane
[357.983988] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.148s)
[357.992388] Starting dynamic subtest: drm_test_format_block_height_three_plane
[358.129207] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.144s)
[358.137622] Starting dynamic subtest: drm_test_format_block_height_tiled
[358.272920] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.142s)
[358.281405] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[358.414635] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.141s)
[358.425430] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[358.506735] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.092s)
[358.517184] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[358.647260] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.137s)
[358.656897] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[358.800238] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.152s)
[358.815774] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[358.936818] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.135s)
[358.947294] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[359.068628] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.131s)
[359.079203] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[359.193790] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.125s)
[359.204186] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[359.353633] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.160s)
[359.355847] Subtest drm_format: SUCCESS (2.483s)
[359.547618] [082/133] (663s left) gem_close_race (multigpu-basic-process)
[359.624053] Starting subtest: multigpu-basic-process
[359.628656] Subtest multigpu-basic-process: SKIP (0.000s)
[359.892686] [083/133] (662s left) gem_set_tiling_vs_gtt
[360.035632] [084/133] (662s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[360.133468] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[360.135767] Starting dynamic subtest: pipe-A
[360.153721] Dynamic subtest pipe-A: SKIP (0.016s)
[360.163657] Starting dynamic subtest: pipe-B
[360.184359] Dynamic subtest pipe-B: SKIP (0.029s)
[360.193790] Starting dynamic subtest: pipe-C
[360.210923] Dynamic subtest pipe-C: SKIP (0.028s)
[360.220321] Starting dynamic subtest: pipe-D
[360.240628] Dynamic subtest pipe-D: SKIP (0.029s)
[360.244673] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.105s)
[360.363872] [085/133] (662s left) kms_addfb_basic (basic-y-tiled-legacy)
[360.423214] Starting subtest: basic-y-tiled-legacy
[360.427477] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[360.598712] [086/133] (662s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[360.709217] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[361.743222] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.033s)
[361.903474] [087/133] (660s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[361.971831] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[361.975436] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[362.167840] [088/133] (660s left) gem_caching (writes)
[362.234692] Subtest writes: SKIP (0.000s)
[362.311922] [089/133] (660s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[362.374646] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[362.482618] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[362.570047] [090/133] (660s left) kms_flip (wf_vblank-ts-check)
[362.674743] Starting subtest: wf_vblank-ts-check
[362.677130] Starting dynamic subtest: A-eDP1
[371.553682] Dynamic subtest A-eDP1: SUCCESS (8.877s)
[371.563679] Starting dynamic subtest: B-eDP1
[380.485234] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[380.496802] Starting dynamic subtest: C-eDP1
[389.409976] Dynamic subtest C-eDP1: SUCCESS (8.922s)
[389.420318] Starting dynamic subtest: D-eDP1
[398.347424] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[398.349420] Subtest wf_vblank-ts-check: SUCCESS (35.671s)
[399.585452] [091/133] (623s left) gem_lmem_evict (dontneed-evict-race)
[399.625898] Subtest dontneed-evict-race: SKIP (0.000s)
[399.688935] [092/133] (623s left) gem_mmap_gtt (medium-copy-odd)
[399.750373] Subtest medium-copy-odd: SKIP (0.000s)
[399.821285] [093/133] (623s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[399.920613] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[399.933379] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[400.006642] [094/133] (623s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[400.092820] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[400.095007] Starting dynamic subtest: pipe-A-eDP-1
[400.151377] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[400.160046] Starting dynamic subtest: pipe-B-eDP-1
[400.216102] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[400.226270] Starting dynamic subtest: pipe-C-eDP-1
[400.284527] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[400.294890] Starting dynamic subtest: pipe-D-eDP-1
[400.352331] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[400.356603] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[402.271076] [095/133] (620s left) gem_exec_suspend (basic-s0)
[402.332600] Starting subtest: basic-S0
[402.334792] Starting dynamic subtest: smem
[423.413015] Dynamic subtest smem: SUCCESS (6.892s)
[423.415703] Subtest basic-S0: SUCCESS (6.894s)
[423.634280] [096/133] (599s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[423.745660] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[424.734045] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.986s)
[424.869768] [097/133] (598s left) gem_mmap_offset (bad-extensions)
[424.926908] Starting subtest: bad-extensions
[424.928915] Subtest bad-extensions: SUCCESS (0.000s)
[425.060436] [098/133] (598s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[425.176681] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[425.180329] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[425.333028] [099/133] (598s left) gem_mmap_gtt (cpuset-big-copy-odd)
[425.387467] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[425.451679] [100/133] (597s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[425.555404] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[425.559134] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[425.682363] [101/133] (597s left) kms_psr (fbc-psr2-sprite-render)
[425.775014] Starting subtest: fbc-psr2-sprite-render
[425.776865] Starting dynamic subtest: eDP-1
[425.780161] Dynamic subtest eDP-1: SKIP (0.000s)
[425.783483] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[425.888054] [102/133] (597s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[425.997657] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[426.000986] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[426.127308] [103/133] (597s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[426.217702] Starting subtest: crc-primary-basic-y-tiled-ccs
[426.219566] Starting dynamic subtest: pipe-A-eDP-1
[426.237890] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[426.248664] Starting dynamic subtest: pipe-B-eDP-1
[426.265644] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[426.275128] Starting dynamic subtest: pipe-C-eDP-1
[426.292124] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[426.300919] Starting dynamic subtest: pipe-D-eDP-1
[426.318807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[426.322284] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[428.501586] [104/133] (595s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[428.603640] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[428.607991] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[428.732720] [105/133] (594s left) api_intel_bb (add-remove-objects)
[428.783862] Starting subtest: add-remove-objects
[428.788722] Subtest add-remove-objects: SUCCESS (0.007s)
[428.900604] [106/133] (594s left) sysfs_heartbeat_interval (nopreempt)
[428.959792] Starting subtest: nopreempt
[428.962094] Starting dynamic subtest: vecs0
[438.397701] Dynamic subtest vecs0: SUCCESS (9.427s)
[438.408675] Starting dynamic subtest: ccs0
[442.471384] Dynamic subtest ccs0: SUCCESS (4.067s)
[442.483306] Starting dynamic subtest: vcs0
[452.406494] Dynamic subtest vcs0: SUCCESS (9.929s)
[452.419075] Starting dynamic subtest: bcs0
[456.423336] Dynamic subtest bcs0: SUCCESS (4.015s)
[456.435544] Starting dynamic subtest: rcs0
[460.521900] Dynamic subtest rcs0: SUCCESS (4.101s)
[460.534181] Starting dynamic subtest: vcs1
[470.405790] Dynamic subtest vcs1: SUCCESS (9.887s)
[470.408455] Subtest nopreempt: SUCCESS (41.439s)
[470.499200] [107/133] (553s left) kms_getfb (getfb2-into-addfb2)
[470.609297] Starting subtest: getfb2-into-addfb2
[470.611510] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[470.729867] [108/133] (553s left) gem_close (basic)
[470.787051] Starting subtest: basic
[470.789632] Subtest basic: SUCCESS (0.000s)
[470.894712] [109/133] (552s left) gem_exec_schedule (preemptive-hang)
[471.071593] Starting subtest: preemptive-hang
[471.074265] Starting dynamic subtest: rcs0
[480.552903] Dynamic subtest rcs0: SUCCESS (9.478s)
[480.563215] Starting dynamic subtest: bcs0
[489.567213] Dynamic subtest bcs0: SUCCESS (9.013s)
[489.577388] Starting dynamic subtest: vcs0
[498.561903] Dynamic subtest vcs0: SUCCESS (8.992s)
[498.573006] Starting dynamic subtest: vcs1
[507.554148] Dynamic subtest vcs1: SUCCESS (8.990s)
[507.565950] Starting dynamic subtest: vecs0
[516.503646] Dynamic subtest vecs0: SUCCESS (8.947s)
[516.515915] Starting dynamic subtest: ccs0
[525.534362] Dynamic subtest ccs0: SUCCESS (9.031s)
[525.536730] Subtest preemptive-hang: SUCCESS (54.459s)
[525.796556] [110/133] (498s left) i915_drm_fdinfo (virtual-busy-idle)
[525.837737] Starting subtest: virtual-busy-idle
[525.842402] Subtest virtual-busy-idle: SKIP (0.000s)
[525.917659] [111/133] (498s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[526.022605] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[529.920585] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.903s)
[531.094635] [112/133] (492s left) gem_linear_blits (interruptible)
[531.309168] Starting subtest: interruptible
[535.435735] Subtest interruptible: SUCCESS (4.125s)
[535.635339] [113/133] (488s left) gem_ctx_persistence (engines-mixed)
[535.742428] Starting subtest: engines-mixed
[535.744685] Starting dynamic subtest: rcs0
[535.877969] Dynamic subtest rcs0: SUCCESS (0.135s)
[535.890211] Starting dynamic subtest: bcs0
[535.956925] Dynamic subtest bcs0: SUCCESS (0.076s)
[535.969446] Starting dynamic subtest: vcs0
[536.044009] Dynamic subtest vcs0: SUCCESS (0.085s)
[536.056894] Starting dynamic subtest: vcs1
[536.118068] Dynamic subtest vcs1: SUCCESS (0.072s)
[536.130333] Starting dynamic subtest: vecs0
[536.199680] Dynamic subtest vecs0: SUCCESS (0.079s)
[536.211544] Starting dynamic subtest: ccs0
[536.239988] Dynamic subtest ccs0: SUCCESS (0.039s)
[536.242235] Subtest engines-mixed: SUCCESS (0.498s)
[536.379266] [114/133] (487s left) perf_pmu (init-wait)
[536.424696] Starting subtest: init-wait
[536.426965] Starting dynamic subtest: rcs0
[536.429056] Dynamic subtest rcs0: SUCCESS (0.002s)
[536.443602] Starting dynamic subtest: bcs0
[536.445711] Dynamic subtest bcs0: SUCCESS (0.000s)
[536.454592] Starting dynamic subtest: vcs0
[536.456438] Dynamic subtest vcs0: SUCCESS (0.000s)
[536.464817] Starting dynamic subtest: vcs1
[536.466439] Dynamic subtest vcs1: SUCCESS (0.001s)
[536.474662] Starting dynamic subtest: vecs0
[536.476233] Dynamic subtest vecs0: SUCCESS (0.001s)
[536.484931] Starting dynamic subtest: ccs0
[536.486734] Dynamic subtest ccs0: SUCCESS (0.000s)
[536.488509] Subtest init-wait: SUCCESS (0.008s)
[536.577216] [115/133] (487s left) gem_exec_reloc (basic-gtt-cpu-active)
[536.647256] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[536.724199] [116/133] (487s left) kms_pm_lpsp (screens-disabled)
[537.832220] Starting subtest: screens-disabled
[537.836132] Subtest screens-disabled: SKIP (0.000s)
[537.916732] [117/133] (486s left) kms_flip (flip-vs-expired-vblank-interruptible)
[538.023743] Starting subtest: flip-vs-expired-vblank-interruptible
[538.026041] Starting dynamic subtest: A-eDP1
[546.677366] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[546.688170] Starting dynamic subtest: B-eDP1
[555.307604] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[555.318925] Starting dynamic subtest: C-eDP1
[563.922959] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[563.934938] Starting dynamic subtest: D-eDP1
[572.561580] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[572.566867] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.536s)
[573.751614] [118/133] (450s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[573.844244] Starting subtest: psr-1p-primscrn-cur-indfb-move
[581.104730] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.261s)
[581.299343] [119/133] (442s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[581.394250] Starting subtest: plane-all-modeset-transition-internal-panels
[581.396117] Starting dynamic subtest: pipe-A-eDP-1
[582.702617] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.308s)
[582.987980] Starting dynamic subtest: pipe-B-eDP-1
[584.028278] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.048s)
[584.313141] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.920s)
[585.159648] [120/133] (439s left) gem_userptr_blits (stress-mm)
[585.231439] Starting subtest: stress-mm
[590.600634] Subtest stress-mm: SUCCESS (5.369s)
[590.760332] [121/133] (433s left) syncobj_eventfd (invalid-bad-flags)
[590.822868] Starting subtest: invalid-bad-flags
[590.825149] Subtest invalid-bad-flags: SUCCESS (0.000s)
[590.926841] [122/133] (433s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[590.980562] Starting subtest: framebuffer-vs-set-tiling
[590.985444] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[591.147722] [123/133] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[591.242651] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[591.246792] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[591.354647] [124/133] (433s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[591.411298] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[591.413465] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[591.519589] [125/133] (432s left) kms_flip (2x-modeset-vs-vblank-race)
[591.619958] Starting subtest: 2x-modeset-vs-vblank-race
[591.628107] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[591.721714] [126/133] (432s left) i915_query (query-regions-garbage-items)
[591.770237] Starting subtest: query-regions-garbage-items
[591.772096] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[591.883089] [127/133] (432s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[591.978577] Starting subtest: flip-primary-invalidate-overlay
[603.600300] Subtest flip-primary-invalidate-overlay: SUCCESS (11.620s)
[603.785026] [128/133] (420s left) gem_exec_balancer (full-late)
[603.859458] Starting subtest: full-late
[608.244211] Subtest full-late: SUCCESS (4.386s)
[608.591271] [129/133] (416s left) gem_exec_reloc (basic-write-wc)
[608.663197] Subtest basic-write-wc: SKIP (0.000s)
[608.740845] [130/133] (415s left) kms_force_connector_basic (force-load-detect)
[608.822855] Starting subtest: force-load-detect
[608.827673] Subtest force-load-detect: SKIP (0.000s)
[608.987211] [131/133] (415s left) kms_chamelium_hpd (hdmi-hpd-fast)
[609.389792] Subtest hdmi-hpd-fast: SKIP (0.000s)
[610.170615] [132/133] (414s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[610.271591] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[610.274193] Starting dynamic subtest: pipe-A-default-mode
[613.013870] Dynamic subtest pipe-A-default-mode: SUCCESS (2.743s)
[613.016290] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.744s)
[613.903208] [133/133] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[614.009072] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[614.013188] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[614.130329] 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.