[58.357597] Initializing watchdogs
[58.357645]   /dev/watchdog0
[58.372274] [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.377314] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.379390] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.381274] [001/133] (960s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[58.544328] Starting subtest: dp-mst-lic-type-0-hdcp14
[58.546212] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[58.665233] [002/133] (960s left) core_getversion (all-cards)
[58.696427] Starting subtest: all-cards
[58.703875] Subtest all-cards: SUCCESS (0.009s)
[58.740635] [003/133] (960s left) kms_atomic_interruptible (legacy-dpms)
[58.825948] Starting subtest: legacy-dpms
[58.826902] Starting dynamic subtest: pipe-A-eDP-1
[66.263421] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.429s)
[66.264235] Subtest legacy-dpms: SUCCESS (7.430s)
[67.136392] [004/133] (951s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[67.316749] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[67.322514] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[67.700963] [005/133] (951s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[67.918126] Starting subtest: plane-primary-toggle-with-vblank-wait
[67.919044] Starting dynamic subtest: pipe-A-eDP-1
[68.093963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[68.400078] Starting dynamic subtest: pipe-B-eDP-1
[69.312283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.920s)
[69.620824] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.701s)
[70.487689] [006/133] (948s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[70.583048] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[70.584922] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.691258] [007/133] (948s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[70.778902] Starting subtest: fbc-psr2-primary-mmap-cpu
[70.779868] Starting dynamic subtest: eDP-1
[70.781392] Dynamic subtest eDP-1: SKIP (0.000s)
[70.782908] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[70.857367] [008/133] (948s left) perf (invalid-oa-exponent)
[70.986660] Starting subtest: invalid-oa-exponent
[70.999941] Subtest invalid-oa-exponent: SUCCESS (0.013s)
[71.029932] [009/133] (948s left) gem_eio (create-ext)
[71.179367] Starting subtest: create-ext
[71.351369] Subtest create-ext: SUCCESS (0.172s)
[71.502473] [010/133] (947s left) kms_color (invalid-degamma-lut-sizes)
[71.603902] Starting subtest: invalid-degamma-lut-sizes
[71.604695] Starting dynamic subtest: pipe-A
[71.901054] Dynamic subtest pipe-A: SUCCESS (0.297s)
[71.907574] Starting dynamic subtest: pipe-B
[71.908477] Dynamic subtest pipe-B: SUCCESS (0.000s)
[71.914120] Starting dynamic subtest: pipe-C
[71.914951] Dynamic subtest pipe-C: SUCCESS (0.000s)
[71.920552] Starting dynamic subtest: pipe-D
[71.921442] Dynamic subtest pipe-D: SUCCESS (0.000s)
[71.922374] Subtest invalid-degamma-lut-sizes: SUCCESS (0.299s)
[72.709883] [011/133] (946s left) gem_softpin (allocator-basic)
[72.761445] Starting subtest: allocator-basic
[72.839107] Subtest allocator-basic: SUCCESS (0.078s)
[72.967719] [012/133] (946s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[73.064013] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[73.067241] Starting dynamic subtest: pipe-A-eDP-1
[78.908811] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.846s)
[78.915499] Starting dynamic subtest: pipe-B-eDP-1
[85.455305] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.545s)
[85.456133] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.393s)
[86.342747] [013/133] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[86.444569] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[86.446399] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[86.559389] [014/133] (932s left) kms_psr (pr-primary-render)
[86.653499] Starting subtest: pr-primary-render
[86.655550] Subtest pr-primary-render: SKIP (0.000s)
[86.728632] [015/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[86.817211] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[86.818866] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[86.914763] [016/133] (932s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[87.009823] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[87.011708] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[87.082452] [017/133] (932s left) gem_ccs (ctrl-surf-copy)
[87.143443] Starting subtest: ctrl-surf-copy
[87.145360] Subtest ctrl-surf-copy: SKIP (0.000s)
[87.260333] [018/133] (932s left) perf (invalid-oa-metric-set-id)
[87.346582] Starting subtest: invalid-oa-metric-set-id
[87.354925] Subtest invalid-oa-metric-set-id: SUCCESS (0.009s)
[87.391359] [019/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[87.489814] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[87.491557] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[87.596113] [020/133] (931s left) gem_pxp (create-regular-buffer)
[87.709947] Starting subtest: create-regular-buffer
[87.711221] Subtest create-regular-buffer: SUCCESS (0.000s)
[87.822339] [021/133] (931s left) gem_eio (in-flight-contexts-10ms)
[88.013882] Starting subtest: in-flight-contexts-10ms
[101.931661] Subtest in-flight-contexts-10ms: SUCCESS (13.918s)
[102.095734] [022/133] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[102.206362] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[108.982520] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.776s)
[109.143518] [023/133] (910s left) gem_exec_schedule (u-fairslice-all)
[109.202325] Starting subtest: u-fairslice-all
[111.259598] Subtest u-fairslice-all: SUCCESS (2.057s)
[111.568360] [024/133] (908s left) core_getstats (basic)
[111.622387] Starting subtest: basic
[111.623453] Subtest basic: SUCCESS (0.000s)
[111.740330] [025/133] (907s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[111.839092] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[111.840069] Starting dynamic subtest: pipe-A-eDP-1
[112.659396] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.818s)
[112.666119] Starting dynamic subtest: pipe-B-eDP-1
[114.194685] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[114.201346] Starting dynamic subtest: pipe-C-eDP-1
[115.684234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[115.690561] Starting dynamic subtest: pipe-D-eDP-1
[117.225470] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.540s)
[117.226332] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.384s)
[118.409302] [026/133] (901s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[118.501670] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[118.502574] Starting dynamic subtest: pipe-A-eDP-1
[118.511433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.518568] Starting dynamic subtest: pipe-B-eDP-1
[118.527204] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.533809] Starting dynamic subtest: pipe-C-eDP-1
[118.541948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.548439] Starting dynamic subtest: pipe-D-eDP-1
[118.556419] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.557978] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[120.776931] [027/133] (898s left) sw_sync (alloc_fence)
[120.809233] Starting subtest: alloc_fence
[120.810180] Subtest alloc_fence: SUCCESS (0.000s)
[120.862042] [028/133] (898s left) i915_pm_rps (basic-api)
[120.931721] Starting subtest: basic-api
[120.933540] Subtest basic-api: SKIP (0.001s)
[121.049341] [029/133] (898s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[121.169598] Starting subtest: cursorB-vs-flipA-toggle
[121.172540] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[121.333024] [030/133] (898s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[121.542284] Starting subtest: cursor-rapid-movement-128x42
[121.585355] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[121.814541] [031/133] (897s left) kms_dp_link_training (non-uhbr-sst)
[121.898021] Starting subtest: non-uhbr-sst
[121.901628] Subtest non-uhbr-sst: SKIP (0.000s)
[121.974336] [032/133] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[122.084805] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[122.086696] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[122.194026] [033/133] (897s left) gem_exec_parallel (engines)
[122.250502] Starting subtest: engines
[122.251496] Starting dynamic subtest: basic
[123.958723] Dynamic subtest basic: SUCCESS (1.698s)
[123.967795] Starting dynamic subtest: contexts
[128.335890] Dynamic subtest contexts: SUCCESS (4.375s)
[128.343083] Starting dynamic subtest: fds
[132.190712] Dynamic subtest fds: SUCCESS (3.852s)
[132.197409] Starting dynamic subtest: userptr
[133.951734] Dynamic subtest userptr: SUCCESS (1.759s)
[133.953049] Subtest engines: SUCCESS (11.691s)
[134.135916] [034/133] (885s left) gem_eio (in-flight-immediate)
[134.377047] Starting subtest: in-flight-immediate
[143.080266] Subtest in-flight-immediate: SUCCESS (8.704s)
[143.202615] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[143.204358] [035/133] (876s left) prime_mmap (test_forked)
[143.248293] Starting subtest: test_forked
[143.249300] Starting dynamic subtest: test_forked-smem
[143.284313] Dynamic subtest test_forked-smem: SUCCESS (0.037s)
[143.285363] Subtest test_forked: SUCCESS (0.038s)
[143.408445] [036/133] (876s left) kms_dsc (dsc-with-formats)
[143.501422] Starting subtest: dsc-with-formats
[143.515979] Subtest dsc-with-formats: SKIP (0.001s)
[143.578307] [037/133] (876s left) prime_busy (hang)
[143.635425] Starting subtest: hang
[143.636283] Starting dynamic subtest: rcs0
[170.415295] Dynamic subtest rcs0: SUCCESS (26.775s)
[170.421907] Starting dynamic subtest: bcs0
[177.570561] Dynamic subtest bcs0: SUCCESS (7.155s)
[177.577290] Starting dynamic subtest: vcs0
[184.544154] Dynamic subtest vcs0: SUCCESS (6.973s)
[184.550711] Starting dynamic subtest: vcs1
[191.587311] Dynamic subtest vcs1: SUCCESS (7.042s)
[191.594685] Starting dynamic subtest: vecs0
[198.557505] Dynamic subtest vecs0: SUCCESS (6.969s)
[198.564767] Starting dynamic subtest: ccs0
[212.395890] Dynamic subtest ccs0: SUCCESS (13.838s)
[212.396878] Subtest hang: SUCCESS (68.757s)
[212.519123] [038/133] (807s left) kms_vblank (wait-idle)
[212.620058] Starting subtest: wait-idle
[212.620866] Starting dynamic subtest: pipe-A-eDP-1
[214.373961] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[214.383026] Starting dynamic subtest: pipe-D-eDP-1
[216.791521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.416s)
[216.792441] Subtest wait-idle: SUCCESS (4.172s)
[217.625137] [039/133] (802s left) kms_pm_rpm (package-g7)
[219.142466] Starting subtest: package-g7
[219.145039] Subtest package-g7: SKIP (0.000s)
[219.862580] [040/133] (800s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[219.966638] Starting subtest: flip-vs-cursor-varying-size
[228.569240] Subtest flip-vs-cursor-varying-size: SUCCESS (8.601s)
[229.378829] [041/133] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[229.487827] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[236.878556] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.391s)
[237.008897] [042/133] (783s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[237.060178] Starting subtest: single-wait-all-for-submit-signaled
[237.061039] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[237.184856] [043/133] (783s left) perf (gen12-group-exclusive-stream-ctx-handle)
[237.267164] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[237.291014] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[237.330209] [044/133] (782s left) gem_wait (busy)
[238.912854] Starting subtest: busy
[238.914043] Starting dynamic subtest: all-engines
[240.926632] Dynamic subtest all-engines: SUCCESS (2.004s)
[240.935796] Starting dynamic subtest: rcs0
[241.469999] Dynamic subtest rcs0: SUCCESS (0.551s)
[241.479480] Starting dynamic subtest: bcs0
[242.010937] Dynamic subtest bcs0: SUCCESS (0.540s)
[242.019894] Starting dynamic subtest: vcs0
[243.934490] Dynamic subtest vcs0: SUCCESS (1.913s)
[243.943882] Starting dynamic subtest: vcs1
[245.918691] Dynamic subtest vcs1: SUCCESS (1.982s)
[245.928083] Starting dynamic subtest: vecs0
[247.901989] Dynamic subtest vecs0: SUCCESS (1.982s)
[247.911290] Starting dynamic subtest: ccs0
[248.436574] Dynamic subtest ccs0: SUCCESS (0.542s)
[248.437631] Subtest busy: SUCCESS (9.524s)
[248.641024] [045/133] (771s left) gen9_exec_parse (bb-secure)
[248.699190] Subtest bb-secure: SKIP (0.000s)
[248.759838] [046/133] (771s left) kms_cursor_edge_walk (128x128-right-edge)
[248.861369] Starting subtest: 128x128-right-edge
[248.863471] Starting dynamic subtest: pipe-A-eDP-1
[252.383999] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.521s)
[252.391386] Starting dynamic subtest: pipe-D-eDP-1
[255.503653] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[255.504554] Subtest 128x128-right-edge: SUCCESS (6.642s)
[256.317422] [047/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[256.418392] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[256.420152] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[256.553096] [048/133] (763s left) prime_mmap (test_forked_cpu_write)
[256.601119] Starting subtest: test_forked_cpu_write
[256.601931] Starting dynamic subtest: test_forked_cpu_write-smem
[256.606819] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.006s)
[256.608141] Subtest test_forked_cpu_write: SUCCESS (0.007s)
[256.723766] [049/133] (763s left) kms_addfb_basic (small-bo)
[256.816051] Starting subtest: small-bo
[256.816943] Subtest small-bo: SUCCESS (0.000s)
[256.918731] [050/133] (763s left) kms_chamelium_audio (dp-audio)
[257.302530] Subtest dp-audio: SKIP (0.000s)
[258.127175] [051/133] (762s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[258.510857] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[259.364298] [052/133] (761s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[259.458410] Starting subtest: psr-shrfb-scaledprimary
[265.299300] Subtest psr-shrfb-scaledprimary: SUCCESS (5.841s)
[265.432476] [053/133] (755s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[265.526290] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[265.527898] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[265.605236] [054/133] (754s left) perf (i915-ref-count)
[265.670069] Starting subtest: i915-ref-count
[265.696883] Subtest i915-ref-count: SUCCESS (0.025s)
[265.749450] [055/133] (754s left) kms_joiner (invalid-modeset-force-big-joiner)
[265.832786] Starting subtest: invalid-modeset-force-big-joiner
[265.834528] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[265.915470] [056/133] (754s left) kms_cursor_crc (cursor-alpha-opaque)
[266.005511] Starting subtest: cursor-alpha-opaque
[266.006352] Starting dynamic subtest: pipe-A-eDP-1
[266.629916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[266.637071] Starting dynamic subtest: pipe-D-eDP-1
[267.878879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[267.879769] Subtest cursor-alpha-opaque: SUCCESS (1.874s)
[268.679750] [057/133] (751s left) kms_legacy_colorkey (basic)
[268.772283] Starting subtest: basic
[268.773113] Starting dynamic subtest: pipe-A
[268.816938] Dynamic subtest pipe-A: SUCCESS (0.045s)
[268.828204] Starting dynamic subtest: pipe-B
[268.829165] Dynamic subtest pipe-B: SUCCESS (0.001s)
[268.835670] Starting dynamic subtest: pipe-C
[268.836545] Dynamic subtest pipe-C: SUCCESS (0.000s)
[268.842922] Starting dynamic subtest: pipe-D
[268.843819] Dynamic subtest pipe-D: SUCCESS (0.000s)
[268.844682] Subtest basic: SUCCESS (0.050s)
[268.891473] [058/133] (751s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[268.988225] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[268.989964] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[269.095202] [059/133] (751s left) kms_addfb_basic (bad-pitch-32)
[269.143498] Starting subtest: bad-pitch-32
[269.144392] Subtest bad-pitch-32: SUCCESS (0.000s)
[269.284127] [060/133] (751s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[269.334653] Starting subtest: x-tiled-to-vebox-y-tiled
[269.336743] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[269.525250] [061/133] (751s left) gem_exec_reloc (basic-range)
[269.577220] Subtest basic-range: SKIP (0.000s)
[269.633758] [062/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[269.735489] Starting subtest: yf-tiled-64bpp-rotate-0
[269.737289] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[269.832673] [063/133] (751s left) syncobj_wait (wait-all-for-submit-snapshot)
[269.887013] Starting subtest: wait-all-for-submit-snapshot
[269.969031] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[270.052920] [064/133] (750s left) kms_async_flips (invalid-async-flip)
[270.143566] Starting subtest: invalid-async-flip
[270.516940] Starting dynamic subtest: pipe-A-eDP-1
[271.305239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[271.667406] Starting dynamic subtest: pipe-B-eDP-1
[272.435775] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.774s)
[272.789839] Starting dynamic subtest: pipe-C-eDP-1
[273.555513] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.771s)
[273.907803] Starting dynamic subtest: pipe-D-eDP-1
[274.709201] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.807s)
[274.710233] Subtest invalid-async-flip: SUCCESS (4.567s)
[275.849185] [065/133] (745s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[275.952059] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[275.953166] Starting dynamic subtest: A-eDP1
[279.565549] Dynamic subtest A-eDP1: SUCCESS (3.612s)
[279.574171] Starting dynamic subtest: B-eDP1
[282.753666] Dynamic subtest B-eDP1: SUCCESS (3.187s)
[282.762340] Starting dynamic subtest: C-eDP1
[285.828689] Dynamic subtest C-eDP1: SUCCESS (3.073s)
[285.836300] Starting dynamic subtest: D-eDP1
[288.930036] Dynamic subtest D-eDP1: SUCCESS (3.101s)
[288.932254] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.980s)
[289.733325] [066/133] (731s left) kms_frontbuffer_tracking (fbc-suspend)
[289.831222] Starting subtest: fbc-suspend
[328.107328] Subtest fbc-suspend: SUCCESS (8.336s)
[331.330818] [067/133] (691s left) syncobj_timeline (invalid-transfer-bad-pad)
[331.390483] Starting subtest: invalid-transfer-bad-pad
[331.391771] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[331.510747] [068/133] (691s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[331.611017] Starting subtest: 4-tiled-64bpp-rotate-90
[331.631278] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[331.778813] [069/133] (691s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[331.846837] Starting subtest: saturated-hostile-nopreempt
[331.847895] Starting dynamic subtest: rcs0
[331.954127] Dynamic subtest rcs0: SKIP (0.105s)
[331.964001] Starting dynamic subtest: bcs0
[331.976719] Dynamic subtest bcs0: SKIP (0.022s)
[331.984422] Starting dynamic subtest: vcs0
[332.000694] Dynamic subtest vcs0: SKIP (0.022s)
[332.008469] Starting dynamic subtest: vcs1
[332.025777] Dynamic subtest vcs1: SKIP (0.023s)
[332.033359] Starting dynamic subtest: vecs0
[332.050716] Dynamic subtest vecs0: SKIP (0.024s)
[332.058232] Starting dynamic subtest: ccs0
[332.074711] Dynamic subtest ccs0: SKIP (0.022s)
[332.076540] Subtest saturated-hostile-nopreempt: SKIP (0.226s)
[332.161496] [070/133] (690s left) gem_exec_big (single)
[332.218970] Starting subtest: single
[334.668411] Subtest single: SUCCESS (2.417s)
[335.061129] [071/133] (688s left) gem_exec_fence (submit67)
[335.667015] Starting subtest: submit67
[335.668761] Subtest submit67: SKIP (0.000s)
[337.968018] [072/133] (685s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[338.078047] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[338.081293] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[338.199944] [073/133] (685s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[338.296424] Starting subtest: fbc-rgb101010-draw-mmap-wc
[342.933613] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.621s)
[344.064225] [074/133] (679s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[344.183627] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[344.185463] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[344.285114] [075/133] (679s left) i915_drm_fdinfo (busy-idle)
[344.324918] Starting subtest: busy-idle
[344.325791] Starting dynamic subtest: rcs0
[344.373701] Dynamic subtest rcs0: SKIP (0.047s)
[344.384386] Starting dynamic subtest: bcs0
[344.386461] Dynamic subtest bcs0: SKIP (0.001s)
[344.394045] Starting dynamic subtest: vcs0
[344.395808] Dynamic subtest vcs0: SKIP (0.000s)
[344.403164] Starting dynamic subtest: vcs1
[344.404999] Dynamic subtest vcs1: SKIP (0.000s)
[344.412424] Starting dynamic subtest: vecs0
[344.414308] Dynamic subtest vecs0: SKIP (0.000s)
[344.421710] Starting dynamic subtest: ccs0
[344.423561] Dynamic subtest ccs0: SKIP (0.000s)
[344.425394] Subtest busy-idle: SKIP (0.054s)
[344.462622] [076/133] (679s left) kms_psr (psr2-primary-page-flip)
[344.557475] Starting subtest: psr2-primary-page-flip
[344.558481] Starting dynamic subtest: eDP-1
[346.338310] Dynamic subtest eDP-1: SUCCESS (1.776s)
[346.339222] Subtest psr2-primary-page-flip: SUCCESS (1.777s)
[347.236390] [077/133] (676s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[347.350266] Starting subtest: cursorA-vs-flipB-atomic
[347.352066] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[347.517501] [078/133] (676s left) kms_prop_blob (blob-prop-lifetime)
[347.569004] Starting subtest: blob-prop-lifetime
[347.569989] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[347.693710] [079/133] (675s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[347.785239] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[347.786123] Starting dynamic subtest: pipe-A
[347.905192] Dynamic subtest pipe-A: SKIP (0.117s)
[347.913374] Starting dynamic subtest: pipe-B
[349.098928] Dynamic subtest pipe-B: SKIP (1.192s)
[349.107003] Starting dynamic subtest: pipe-C
[350.241482] Dynamic subtest pipe-C: SUCCESS (1.142s)
[350.249916] Starting dynamic subtest: pipe-D
[351.386206] Dynamic subtest pipe-D: SUCCESS (1.143s)
[351.387228] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.597s)
[352.594965] [080/133] (671s left) kms_pipe_crc_basic (hang-read-crc)
[352.697485] Starting subtest: hang-read-crc
[352.698452] Starting dynamic subtest: pipe-A-eDP-1
[354.846894] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.148s)
[354.859760] Starting dynamic subtest: pipe-B-eDP-1
[357.526845] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.677s)
[357.538052] Starting dynamic subtest: pipe-C-eDP-1
[360.146488] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.618s)
[360.156912] Starting dynamic subtest: pipe-D-eDP-1
[362.819712] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.672s)
[362.820604] Subtest hang-read-crc: SUCCESS (10.120s)
[363.658401] [081/133] (660s left) kms_selftest (drm_format)
[363.698540] Starting subtest: drm_format
[363.708958] Starting dynamic subtest: drm_test_format_block_width_invalid
[363.811919] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.103s)
[363.821829] Starting dynamic subtest: drm_test_format_block_width_one_plane
[363.914291] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.103s)
[363.923977] Starting dynamic subtest: drm_test_format_block_width_two_plane
[364.072820] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.149s)
[364.082467] Starting dynamic subtest: drm_test_format_block_width_three_plane
[364.219912] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.145s)
[364.229800] Starting dynamic subtest: drm_test_format_block_width_tiled
[364.290320] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.079s)
[364.300608] Starting dynamic subtest: drm_test_format_block_height_invalid
[364.370362] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.079s)
[364.379456] Starting dynamic subtest: drm_test_format_block_height_one_plane
[364.505973] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.125s)
[364.515934] Starting dynamic subtest: drm_test_format_block_height_two_plane
[364.638975] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.133s)
[364.648347] Starting dynamic subtest: drm_test_format_block_height_three_plane
[364.742232] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.111s)
[364.751419] Starting dynamic subtest: drm_test_format_block_height_tiled
[364.862293] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.119s)
[364.871370] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[364.979604] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.117s)
[364.989364] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[365.114344] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.125s)
[365.124147] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[365.198372] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.093s)
[365.207800] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[365.338923] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.131s)
[365.347368] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[365.450027] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.119s)
[365.459320] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[365.565409] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.113s)
[365.574314] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[365.675165] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.109s)
[365.684275] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[365.818536] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.135s)
[365.819416] Subtest drm_format: SUCCESS (2.112s)
[366.015350] [082/133] (657s left) gem_close_race (multigpu-basic-process)
[366.078089] Starting subtest: multigpu-basic-process
[366.080388] Subtest multigpu-basic-process: SKIP (0.000s)
[366.332074] [083/133] (657s left) gem_set_tiling_vs_gtt
[366.450694] [084/133] (657s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[366.553022] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[366.553998] Starting dynamic subtest: pipe-A
[366.571713] Dynamic subtest pipe-A: SKIP (0.017s)
[366.579938] Starting dynamic subtest: pipe-B
[366.602649] Dynamic subtest pipe-B: SKIP (0.031s)
[366.610714] Starting dynamic subtest: pipe-C
[366.634380] Dynamic subtest pipe-C: SKIP (0.030s)
[366.642364] Starting dynamic subtest: pipe-D
[366.664841] Dynamic subtest pipe-D: SKIP (0.030s)
[366.666395] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[366.798710] [085/133] (656s left) kms_addfb_basic (basic-y-tiled-legacy)
[366.861421] Starting subtest: basic-y-tiled-legacy
[366.863209] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[367.027450] [086/133] (656s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[367.135271] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[368.291917] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.157s)
[368.398848] [087/133] (655s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[368.467548] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[368.469396] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[368.659542] [088/133] (655s left) gem_caching (writes)
[368.709799] Subtest writes: SKIP (0.000s)
[368.793310] [089/133] (655s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[368.858182] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[368.966216] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[369.049034] [090/133] (654s left) kms_flip (wf_vblank-ts-check)
[369.149719] Starting subtest: wf_vblank-ts-check
[369.153262] Starting dynamic subtest: A-eDP1
[378.107611] Dynamic subtest A-eDP1: SUCCESS (8.954s)
[378.117329] Starting dynamic subtest: B-eDP1
[387.066721] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[387.077789] Starting dynamic subtest: C-eDP1
[396.005095] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[396.016156] Starting dynamic subtest: D-eDP1
[404.905342] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[404.910736] Subtest wf_vblank-ts-check: SUCCESS (35.752s)
[406.134155] [091/133] (617s left) gem_lmem_evict (dontneed-evict-race)
[406.173994] Subtest dontneed-evict-race: SKIP (0.000s)
[406.211243] [092/133] (617s left) gem_mmap_gtt (medium-copy-odd)
[406.271499] Subtest medium-copy-odd: SKIP (0.000s)
[406.339665] [093/133] (617s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[406.423323] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[406.428447] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[406.506702] [094/133] (617s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[406.590286] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[406.591203] Starting dynamic subtest: pipe-A-eDP-1
[406.612539] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[406.621331] Starting dynamic subtest: pipe-B-eDP-1
[406.642762] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[406.651571] Starting dynamic subtest: pipe-C-eDP-1
[406.671833] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[406.679625] Starting dynamic subtest: pipe-D-eDP-1
[406.699267] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[406.700751] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[408.887776] [095/133] (615s left) gem_exec_suspend (basic-s0)
[408.952573] Starting subtest: basic-S0
[408.953780] Starting dynamic subtest: smem
[429.135954] Dynamic subtest smem: SUCCESS (6.862s)
[429.137568] Subtest basic-S0: SUCCESS (6.864s)
[436.341478] [096/133] (594s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[436.454501] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[437.631636] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.168s)
[437.775025] [097/133] (593s left) gem_mmap_offset (bad-extensions)
[437.826281] Starting subtest: bad-extensions
[437.827190] Subtest bad-extensions: SUCCESS (0.000s)
[437.954946] [098/133] (593s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[438.070872] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[438.073765] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[438.236573] [099/133] (593s left) gem_mmap_gtt (cpuset-big-copy-odd)
[438.286785] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[438.348332] [100/133] (592s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[438.451334] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[438.453660] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[438.548236] [101/133] (592s left) kms_psr (fbc-psr2-sprite-render)
[438.634605] Starting subtest: fbc-psr2-sprite-render
[438.635465] Starting dynamic subtest: eDP-1
[438.637141] Dynamic subtest eDP-1: SKIP (0.000s)
[438.638791] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[438.716731] [102/133] (592s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[438.814584] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[438.816188] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[438.945112] [103/133] (592s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[439.037587] Starting subtest: crc-primary-basic-y-tiled-ccs
[439.038464] Starting dynamic subtest: pipe-A-eDP-1
[439.046910] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[439.054870] Starting dynamic subtest: pipe-B-eDP-1
[439.062708] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[439.070527] Starting dynamic subtest: pipe-C-eDP-1
[439.079523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[439.089636] Starting dynamic subtest: pipe-D-eDP-1
[439.097888] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[439.099434] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.011s)
[441.305870] [104/133] (590s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[441.400479] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[441.402115] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[441.517735] [105/133] (589s left) api_intel_bb (add-remove-objects)
[441.562396] Starting subtest: add-remove-objects
[441.568674] Subtest add-remove-objects: SUCCESS (0.007s)
[441.733173] [106/133] (589s left) sysfs_heartbeat_interval (nopreempt)
[441.782983] Starting subtest: nopreempt
[441.783929] Starting dynamic subtest: vecs0
[451.165825] Dynamic subtest vecs0: SUCCESS (9.341s)
[451.176647] Starting dynamic subtest: ccs0
[455.274861] Dynamic subtest ccs0: SUCCESS (4.108s)
[455.289600] Starting dynamic subtest: vcs0
[465.192197] Dynamic subtest vcs0: SUCCESS (9.908s)
[465.204373] Starting dynamic subtest: bcs0
[469.144574] Dynamic subtest bcs0: SUCCESS (3.946s)
[469.154833] Starting dynamic subtest: rcs0
[473.163164] Dynamic subtest rcs0: SUCCESS (4.019s)
[473.173648] Starting dynamic subtest: vcs1
[483.162946] Dynamic subtest vcs1: SUCCESS (10.000s)
[483.166124] Subtest nopreempt: SUCCESS (41.335s)
[483.266510] [107/133] (548s left) kms_getfb (getfb2-into-addfb2)
[483.368700] Starting subtest: getfb2-into-addfb2
[483.369603] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[483.492129] [108/133] (548s left) gem_close (basic)
[483.553010] Starting subtest: basic
[483.553894] Subtest basic: SUCCESS (0.000s)
[483.684946] [109/133] (547s left) gem_exec_schedule (preemptive-hang)
[483.882344] Starting subtest: preemptive-hang
[483.883509] Starting dynamic subtest: rcs0
[493.297464] Dynamic subtest rcs0: SUCCESS (9.422s)
[493.307921] Starting dynamic subtest: bcs0
[502.318443] Dynamic subtest bcs0: SUCCESS (9.017s)
[502.332717] Starting dynamic subtest: vcs0
[511.348203] Dynamic subtest vcs0: SUCCESS (9.028s)
[511.359307] Starting dynamic subtest: vcs1
[520.301083] Dynamic subtest vcs1: SUCCESS (8.950s)
[520.310615] Starting dynamic subtest: vecs0
[529.324411] Dynamic subtest vecs0: SUCCESS (9.017s)
[529.334696] Starting dynamic subtest: ccs0
[538.285044] Dynamic subtest ccs0: SUCCESS (8.958s)
[538.286291] Subtest preemptive-hang: SUCCESS (54.403s)
[538.538684] [110/133] (493s left) i915_drm_fdinfo (virtual-busy-idle)
[538.573537] Starting subtest: virtual-busy-idle
[538.575341] Subtest virtual-busy-idle: SKIP (0.000s)
[538.648734] [111/133] (493s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[538.750026] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[542.769969] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.019s)
[543.971077] [112/133] (487s left) gem_linear_blits (interruptible)
[544.188345] Starting subtest: interruptible
[548.277924] Subtest interruptible: SUCCESS (4.080s)
[548.436570] [113/133] (483s left) gem_ctx_persistence (engines-mixed)
[548.546220] Starting subtest: engines-mixed
[548.547368] Starting dynamic subtest: rcs0
[548.630746] Dynamic subtest rcs0: SUCCESS (0.086s)
[548.641938] Starting dynamic subtest: bcs0
[548.696511] Dynamic subtest bcs0: SUCCESS (0.064s)
[548.708390] Starting dynamic subtest: vcs0
[548.778995] Dynamic subtest vcs0: SUCCESS (0.080s)
[548.795974] Starting dynamic subtest: vcs1
[548.823279] Dynamic subtest vcs1: SUCCESS (0.042s)
[548.832933] Starting dynamic subtest: vecs0
[548.953879] Dynamic subtest vecs0: SUCCESS (0.129s)
[548.967065] Starting dynamic subtest: ccs0
[549.041763] Dynamic subtest ccs0: SUCCESS (0.086s)
[549.043286] Subtest engines-mixed: SUCCESS (0.498s)
[549.136369] [114/133] (482s left) perf_pmu (init-wait)
[549.174552] Starting subtest: init-wait
[549.175576] Starting dynamic subtest: rcs0
[549.178106] Dynamic subtest rcs0: SUCCESS (0.002s)
[549.187090] Starting dynamic subtest: bcs0
[549.187948] Dynamic subtest bcs0: SUCCESS (0.000s)
[549.195688] Starting dynamic subtest: vcs0
[549.196538] Dynamic subtest vcs0: SUCCESS (0.001s)
[549.204332] Starting dynamic subtest: vcs1
[549.205169] Dynamic subtest vcs1: SUCCESS (0.001s)
[549.213172] Starting dynamic subtest: vecs0
[549.214008] Dynamic subtest vecs0: SUCCESS (0.001s)
[549.222485] Starting dynamic subtest: ccs0
[549.223384] Dynamic subtest ccs0: SUCCESS (0.000s)
[549.224208] Subtest init-wait: SUCCESS (0.009s)
[549.312206] [115/133] (482s left) gem_exec_reloc (basic-gtt-cpu-active)
[549.378485] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[549.457996] [116/133] (482s left) kms_pm_lpsp (screens-disabled)
[550.576393] Starting subtest: screens-disabled
[550.578301] Subtest screens-disabled: SKIP (0.000s)
[550.661021] [117/133] (481s left) kms_flip (flip-vs-expired-vblank-interruptible)
[550.770814] Starting subtest: flip-vs-expired-vblank-interruptible
[550.773305] Starting dynamic subtest: A-eDP1
[559.469066] Dynamic subtest A-eDP1: SUCCESS (8.667s)
[559.480276] Starting dynamic subtest: B-eDP1
[568.080988] Dynamic subtest B-eDP1: SUCCESS (8.632s)
[568.092042] Starting dynamic subtest: C-eDP1
[576.743794] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[576.754450] Starting dynamic subtest: D-eDP1
[585.342092] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[585.343307] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.559s)
[586.520441] [118/133] (445s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[586.630559] Starting subtest: psr-1p-primscrn-cur-indfb-move
[593.996241] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.364s)
[594.175760] [119/133] (437s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[594.290802] Starting subtest: plane-all-modeset-transition-internal-panels
[594.291860] Starting dynamic subtest: pipe-A-eDP-1
[595.601169] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.300s)
[595.890484] Starting dynamic subtest: pipe-B-eDP-1
[596.934310] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.043s)
[597.197693] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.907s)
[598.057052] [120/133] (433s left) gem_userptr_blits (stress-mm)
[598.105375] Starting subtest: stress-mm
[603.522915] Subtest stress-mm: SUCCESS (5.369s)
[603.659571] [121/133] (428s left) syncobj_eventfd (invalid-bad-flags)
[603.714971] Starting subtest: invalid-bad-flags
[603.715868] Subtest invalid-bad-flags: SUCCESS (0.000s)
[603.841644] [122/133] (428s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[603.891886] Starting subtest: framebuffer-vs-set-tiling
[603.893838] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[604.059199] [123/133] (428s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[604.141477] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[604.143203] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[604.261970] [124/133] (427s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[604.317914] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[604.318995] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[604.432102] [125/133] (427s left) kms_flip (2x-modeset-vs-vblank-race)
[604.519452] Starting subtest: 2x-modeset-vs-vblank-race
[604.529839] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[604.651471] [126/133] (427s left) i915_query (query-regions-garbage-items)
[604.700697] Starting subtest: query-regions-garbage-items
[604.701641] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[604.813913] [127/133] (427s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[604.912492] Starting subtest: flip-primary-invalidate-overlay
[616.566056] Subtest flip-primary-invalidate-overlay: SUCCESS (11.650s)
[616.722995] [128/133] (415s left) gem_exec_balancer (full-late)
[616.787196] Starting subtest: full-late
[621.065704] Subtest full-late: SUCCESS (4.277s)
[621.402785] [129/133] (410s left) gem_exec_reloc (basic-write-wc)
[621.467250] Subtest basic-write-wc: SKIP (0.000s)
[621.539823] [130/133] (410s left) kms_force_connector_basic (force-load-detect)
[621.603716] Starting subtest: force-load-detect
[621.605592] Subtest force-load-detect: SKIP (0.000s)
[621.730784] [131/133] (410s left) kms_chamelium_hpd (hdmi-hpd-fast)
[622.112017] Subtest hdmi-hpd-fast: SKIP (0.000s)
[622.947522] [132/133] (409s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[623.039020] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[623.039950] Starting dynamic subtest: pipe-A-default-mode
[625.804478] Dynamic subtest pipe-A-default-mode: SUCCESS (2.765s)
[625.805377] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.766s)
[626.695783] [133/133] (405s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[626.795004] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[626.796887] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[626.924196] 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.