[52.257159] Initializing watchdogs
[52.257204]   /dev/watchdog0
[52.270788] [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]
[52.275175] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.277360] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.280809] [001/133] (960s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[52.366294] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[52.368582] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.002s)
[52.486418] [002/133] (960s left) kms_addfb_basic (clobberred-modifier)
[52.542677] Starting subtest: clobberred-modifier
[52.547180] Subtest clobberred-modifier: SKIP (0.000s)
[52.665175] [003/133] (960s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[52.778038] Starting subtest: cursorA-vs-flipA-atomic-transitions
[63.991845] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.213s)
[64.810043] [004/133] (948s left) i915_pm_rpm (gem-idle)
[67.048988] Starting subtest: gem-idle
[73.243286] Subtest gem-idle: SUCCESS (6.196s)
[73.583652] [005/133] (939s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[74.879981] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[74.966239] [006/133] (938s left) gem_exec_fence (expired-history)
[75.393855] Starting subtest: expired-history
[82.568055] Subtest expired-history: SUCCESS (7.175s)
[83.127638] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[83.130844] [007/133] (929s left) sysfs_timeslice_duration (invalid)
[83.201138] Starting subtest: invalid
[83.203449] Starting dynamic subtest: vecs0
[83.205789] Dynamic subtest vecs0: SUCCESS (0.000s)
[83.212670] Starting dynamic subtest: ccs0
[83.214548] Dynamic subtest ccs0: SUCCESS (0.000s)
[83.221098] Starting dynamic subtest: vcs0
[83.222974] Dynamic subtest vcs0: SUCCESS (0.000s)
[83.229535] Starting dynamic subtest: bcs0
[83.231425] Dynamic subtest bcs0: SUCCESS (0.000s)
[83.237784] Starting dynamic subtest: rcs0
[83.239664] Dynamic subtest rcs0: SUCCESS (0.000s)
[83.245994] Starting dynamic subtest: vcs1
[83.248291] Dynamic subtest vcs1: SUCCESS (0.000s)
[83.250494] Subtest invalid: SUCCESS (0.004s)
[83.314307] [008/133] (929s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[83.377184] Subtest writes-after-reads-snoop: SKIP (0.000s)
[83.457601] [009/133] (929s left) syncobj_timeline (device-submit-unordered)
[83.510960] Starting subtest: device-submit-unordered
[83.513459] Subtest device-submit-unordered: SUCCESS (0.000s)
[83.613235] [010/133] (929s left) kms_psr (pr-primary-mmap-gtt)
[83.707101] Starting subtest: pr-primary-mmap-gtt
[83.711666] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[83.776738] [011/133] (929s left) prime_busy (after)
[83.852524] Starting subtest: after
[83.855310] Starting dynamic subtest: rcs0
[83.888037] Dynamic subtest rcs0: SUCCESS (0.034s)
[83.897877] Starting dynamic subtest: bcs0
[83.927949] Dynamic subtest bcs0: SUCCESS (0.039s)
[83.936364] Starting dynamic subtest: vcs0
[83.968264] Dynamic subtest vcs0: SUCCESS (0.040s)
[83.976734] Starting dynamic subtest: vcs1
[84.008813] Dynamic subtest vcs1: SUCCESS (0.040s)
[84.016923] Starting dynamic subtest: vecs0
[84.049389] Dynamic subtest vecs0: SUCCESS (0.040s)
[84.057626] Starting dynamic subtest: ccs0
[84.090856] Dynamic subtest ccs0: SUCCESS (0.041s)
[84.198238] Subtest after: SUCCESS (0.346s)
[84.281581] [012/133] (928s left) i915_drm_fdinfo (memory-info-shared)
[84.321699] Starting subtest: memory-info-shared
[84.323772] Starting dynamic subtest: smem0
[84.375348] Dynamic subtest smem0: SUCCESS (0.056s)
[84.377939] Subtest memory-info-shared: SUCCESS (0.056s)
[84.452116] [013/133] (928s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[84.547923] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[89.198818] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.656s)
[90.407313] [014/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[90.517868] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[96.641589] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.127s)
[97.797658] [015/133] (915s left) kms_pm_dc (dc9-dpms)
[98.898245] Starting subtest: dc9-dpms
[100.322521] Subtest dc9-dpms: SUCCESS (1.426s)
[100.394730] [016/133] (912s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[100.495242] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[100.497574] Starting dynamic subtest: pipe-A-eDP-1
[100.520876] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.529255] Starting dynamic subtest: pipe-B-eDP-1
[100.551108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.557658] Starting dynamic subtest: pipe-C-eDP-1
[100.579270] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.585969] Starting dynamic subtest: pipe-D-eDP-1
[100.607734] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.612156] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[102.727330] [017/133] (910s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[102.824252] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[102.828300] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[102.930130] [018/133] (910s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[103.032313] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[103.034702] Starting dynamic subtest: pipe-A-eDP-1
[103.055781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[103.071290] Starting dynamic subtest: pipe-B-eDP-1
[103.090689] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[103.106217] Starting dynamic subtest: pipe-C-eDP-1
[103.126463] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[103.141543] Starting dynamic subtest: pipe-D-eDP-1
[103.162846] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[103.165202] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[105.278223] [019/133] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[105.398320] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[112.737942] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.342s)
[112.882893] [020/133] (900s left) gem_mmap_offset (open-flood)
[112.939297] Starting subtest: open-flood
[134.425484] Subtest open-flood: SUCCESS (21.489s)
[134.531072] [021/133] (879s left) kms_async_flips (async-flip-hang)
[134.623721] Starting subtest: async-flip-hang
[134.996545] Starting dynamic subtest: pipe-A-eDP-1
[161.395678] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.399s)
[161.780418] Starting dynamic subtest: pipe-B-eDP-1
[177.391874] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.614s)
[177.770437] Starting dynamic subtest: pipe-C-eDP-1
[193.388768] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.622s)
[193.768044] Starting dynamic subtest: pipe-D-eDP-1
[209.390825] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.626s)
[209.393410] Subtest async-flip-hang: SUCCESS (74.766s)
[210.556523] [022/133] (803s left) syncobj_wait (invalid-reset-one-illegal-handle)
[210.610057] Starting subtest: invalid-reset-one-illegal-handle
[210.612269] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[210.714909] [023/133] (802s left) kms_flip (2x-flip-vs-panning-vs-hang)
[210.806082] Starting subtest: 2x-flip-vs-panning-vs-hang
[210.816852] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s)
[210.896928] [024/133] (802s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[211.001563] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[211.005740] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[211.106263] [025/133] (802s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[211.203797] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[211.816739] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[211.987523] [026/133] (801s left) gem_ctx_persistence (many-contexts)
[212.053043] Starting subtest: many-contexts
[257.214181] Subtest many-contexts: SUCCESS (45.159s)
[257.300877] [027/133] (756s left) gem_ctx_param (vm)
[257.351871] Starting subtest: vm
[257.435573] Subtest vm: SUCCESS (0.084s)
[257.569080] [028/133] (756s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[257.682799] Starting subtest: short-busy-flip-before-cursor-toggle
[257.687621] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[257.828326] [029/133] (756s left) gem_mmap_wc (write-cpu-read-wc)
[257.885443] Subtest write-cpu-read-wc: SKIP (0.000s)
[257.938515] [030/133] (755s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[257.998815] Starting subtest: invalid-bsd2-flag-on-blt
[258.001100] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[258.110781] [031/133] (755s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[258.191657] Starting subtest: primary-x-tiled-reflect-x-0
[265.061981] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.870s)
[266.241830] [032/133] (747s left) kms_chamelium_frames (dp-crc-fast)
[266.637912] Subtest dp-crc-fast: SKIP (0.000s)
[267.447078] [033/133] (746s left) gen3_render_mixed_blits
[267.574955] [034/133] (746s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[267.635276] Starting subtest: mixed-tiled-to-y-tiled-ccs
[267.639957] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[267.818060] [035/133] (746s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[267.879541] Starting subtest: single-wait-all-for-submit-available-signaled
[267.881559] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[267.990305] [036/133] (746s left) dumb_buffer (map-invalid-size)
[268.040474] Starting subtest: map-invalid-size
[268.042646] Subtest map-invalid-size: SUCCESS (0.000s)
[268.134396] [037/133] (746s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[268.222075] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[268.226089] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[268.311437] [038/133] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[268.413449] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[272.837050] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.427s)
[273.975504] [039/133] (740s left) kms_rotation_crc (bad-pixel-format)
[274.084585] Starting subtest: bad-pixel-format
[274.088862] Subtest bad-pixel-format: SKIP (0.001s)
[274.155313] [040/133] (740s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[274.248776] Starting subtest: psr-farfromfence-mmap-gtt
[274.252957] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[274.348693] [041/133] (740s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[274.448095] Starting subtest: fbc-rgb565-draw-mmap-wc
[278.460317] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.012s)
[279.651264] [042/133] (734s left) kms_pm_rpm (modeset-lpsp)
[281.168076] Starting subtest: modeset-lpsp
[282.624759] Subtest modeset-lpsp: SUCCESS (1.460s)
[282.711695] [043/133] (731s left) kms_frontbuffer_tracking (psr-2p-rte)
[282.804160] Starting subtest: psr-2p-rte
[282.808150] Subtest psr-2p-rte: SKIP (0.000s)
[282.892375] [044/133] (731s left) gem_lmem_swapping (parallel-random-verify-ccs)
[282.945210] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[282.987458] [045/133] (731s left) perf (gen12-unprivileged-single-ctx-counters)
[283.110153] Starting subtest: gen12-unprivileged-single-ctx-counters
[283.112430] Starting dynamic subtest: rcs0
[283.263863] Dynamic subtest rcs0: SUCCESS (0.156s)
[283.266163] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.158s)
[283.311443] [046/133] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[283.434482] Starting subtest: psr-1p-primscrn-spr-indfb-move
[290.932083] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.500s)
[291.065253] [047/133] (723s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[291.170456] Starting subtest: psr-rgb565-draw-mmap-gtt
[291.174831] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[291.248261] [048/133] (723s left) kms_chamelium_hpd (dp-hpd)
[291.626766] Subtest dp-hpd: SKIP (0.000s)
[292.431397] [049/133] (722s left) kms_setmode (invalid-clone-exclusive-crtc)
[292.484292] Starting subtest: invalid-clone-exclusive-crtc
[292.490832] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[292.574530] [050/133] (722s left) gem_exec_fence (invalid-timeline-fence-array)
[293.138602] Starting subtest: invalid-timeline-fence-array
[293.145409] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[295.018303] [051/133] (719s left) kms_atomic (atomic-invalid-params)
[295.116957] Starting subtest: atomic-invalid-params
[295.119283] Starting dynamic subtest: pipe-A-eDP-1
[295.503481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.387s)
[295.505852] Subtest atomic-invalid-params: SUCCESS (0.389s)
[296.371910] [052/133] (718s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[296.489224] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[296.493651] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[296.599266] [053/133] (718s left) gem_partial_pwrite_pread (write)
[296.660052] Subtest write: SKIP (0.000s)
[296.731638] [054/133] (718s left) core_auth (getclient-simple)
[296.777341] Starting subtest: getclient-simple
[296.787252] Subtest getclient-simple: SUCCESS (0.015s)
[296.891551] [055/133] (718s left) syncobj_timeline (etime-multi-wait-submitted)
[296.953505] Starting subtest: etime-multi-wait-submitted
[297.058401] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[297.149434] [056/133] (717s left) kms_cursor_crc (cursor-sliding-64x21)
[297.354793] Starting subtest: cursor-sliding-64x21
[297.401375] Subtest cursor-sliding-64x21: SKIP (0.042s)
[297.640337] [057/133] (717s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[297.698997] Starting subtest: multi-wait-all-available-submitted-signaled
[297.701245] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[297.792303] [058/133] (717s left) kms_flip (flip-vs-fences-interruptible)
[297.890054] Starting subtest: flip-vs-fences-interruptible
[297.894383] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[297.967124] [059/133] (717s left) gem_spin_batch (engines)
[298.020485] Starting subtest: engines
[298.022826] Starting dynamic subtest: rcs0
[301.259681] Dynamic subtest rcs0: SUCCESS (3.234s)
[301.268646] Starting dynamic subtest: bcs0
[304.499150] Dynamic subtest bcs0: SUCCESS (3.236s)
[304.508958] Starting dynamic subtest: vcs0
[307.734872] Dynamic subtest vcs0: SUCCESS (3.233s)
[307.745023] Starting dynamic subtest: vcs1
[310.971707] Dynamic subtest vcs1: SUCCESS (3.234s)
[310.981313] Starting dynamic subtest: vecs0
[314.208450] Dynamic subtest vecs0: SUCCESS (3.233s)
[314.218277] Starting dynamic subtest: ccs0
[317.445230] Dynamic subtest ccs0: SUCCESS (3.234s)
[317.447666] Subtest engines: SUCCESS (19.421s)
[317.664798] [060/133] (697s left) gem_flink_basic (flink-lifetime)
[317.716484] Starting subtest: flink-lifetime
[317.718595] Subtest flink-lifetime: SUCCESS (0.005s)
[317.821231] [061/133] (697s left) kms_addfb_basic (bo-too-small)
[317.915220] Starting subtest: bo-too-small
[317.917416] Subtest bo-too-small: SUCCESS (0.000s)
[318.013080] [062/133] (697s left) kms_big_fb (linear-64bpp-rotate-180)
[318.107462] Starting subtest: linear-64bpp-rotate-180
[319.598499] Subtest linear-64bpp-rotate-180: SUCCESS (1.492s)
[319.782527] [063/133] (695s left) kms_psr (fbc-psr-basic)
[319.886675] Starting subtest: fbc-psr-basic
[319.888737] Starting dynamic subtest: eDP-1
[319.893081] Dynamic subtest eDP-1: SKIP (0.000s)
[319.897359] Subtest fbc-psr-basic: SKIP (0.001s)
[319.974632] [064/133] (695s left) gem_exec_async (forked-writes)
[320.045508] Starting subtest: forked-writes
[320.047828] Starting dynamic subtest: rcs0
[320.074923] Dynamic subtest rcs0: SUCCESS (0.029s)
[320.086154] Starting dynamic subtest: bcs0
[320.097394] Dynamic subtest bcs0: SUCCESS (0.022s)
[320.105594] Starting dynamic subtest: vcs0
[320.120989] Dynamic subtest vcs0: SUCCESS (0.023s)
[320.129297] Starting dynamic subtest: vcs1
[320.146702] Dynamic subtest vcs1: SUCCESS (0.025s)
[320.154907] Starting dynamic subtest: vecs0
[320.168136] Dynamic subtest vecs0: SUCCESS (0.020s)
[320.176162] Starting dynamic subtest: ccs0
[320.189593] Dynamic subtest ccs0: SUCCESS (0.021s)
[320.191813] Subtest forked-writes: SUCCESS (0.145s)
[320.428907] [065/133] (694s left) gem_exec_schedule (preempt-queue-contexts-chain)
[320.500252] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[320.775328] [066/133] (694s left) gem_exec_schedule (preemptive-hang)
[320.955924] Starting subtest: preemptive-hang
[320.958670] Starting dynamic subtest: rcs0
[330.046488] Dynamic subtest rcs0: SUCCESS (9.089s)
[330.057041] Starting dynamic subtest: bcs0
[339.007938] Dynamic subtest bcs0: SUCCESS (8.960s)
[339.019522] Starting dynamic subtest: vcs0
[348.030787] Dynamic subtest vcs0: SUCCESS (9.020s)
[348.041523] Starting dynamic subtest: vcs1
[357.056036] Dynamic subtest vcs1: SUCCESS (9.024s)
[357.066204] Starting dynamic subtest: vecs0
[366.009324] Dynamic subtest vecs0: SUCCESS (8.954s)
[366.019570] Starting dynamic subtest: ccs0
[375.042067] Dynamic subtest ccs0: SUCCESS (9.031s)
[375.044439] Subtest preemptive-hang: SUCCESS (54.086s)
[375.291068] [067/133] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[375.392813] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[375.397353] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[375.484890] [068/133] (639s left) prime_self_import (export-vs-gem_close-race)
[375.524772] Starting subtest: export-vs-gem_close-race
[380.631328] Subtest export-vs-gem_close-race: SUCCESS (5.106s)
[380.708669] [069/133] (634s left) gem_lmem_swapping (basic)
[380.749803] Subtest basic: SKIP (0.000s)
[380.793722] [070/133] (634s left) kms_prop_blob (blob-prop-lifetime)
[380.845765] Starting subtest: blob-prop-lifetime
[380.848076] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[380.958852] [071/133] (634s left) kms_sequence (get-idle)
[381.057922] Starting subtest: get-idle
[381.060180] Starting dynamic subtest: pipe-A-eDP-1
[382.869241] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[382.878611] Starting dynamic subtest: pipe-B-eDP-1
[385.336679] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s)
[385.344968] Starting dynamic subtest: pipe-C-eDP-1
[387.761901] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s)
[387.771397] Starting dynamic subtest: pipe-D-eDP-1
[390.195468] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[390.197884] Subtest get-idle: SUCCESS (9.139s)
[391.001149] [072/133] (624s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[391.093077] Starting subtest: multiplane-rotation-cropping-bottom
[408.451424] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.360s)
[408.553953] [073/133] (607s left) kms_content_protection (dp-mst-type-0)
[408.706289] Starting subtest: dp-mst-type-0
[408.710130] Subtest dp-mst-type-0: SKIP (0.000s)
[408.829661] [074/133] (606s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[408.915100] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[408.917000] Starting dynamic subtest: pipe-A-eDP-1
[408.924612] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.932345] Starting dynamic subtest: pipe-B-eDP-1
[408.939902] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.947341] Starting dynamic subtest: pipe-C-eDP-1
[408.954577] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.961553] Starting dynamic subtest: pipe-D-eDP-1
[408.968689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.972227] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[411.088940] [075/133] (604s left) vgem_basic (debugfs)
[411.134210] Starting subtest: debugfs
[411.136496] Subtest debugfs: SUCCESS (0.000s)
[411.188995] [076/133] (604s left) perf (whitelisted-registers-userspace-config)
[411.284497] Starting subtest: whitelisted-registers-userspace-config
[411.286807] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[411.335028] [077/133] (604s left) kms_vblank (ts-continuation-dpms-suspend)
[411.432952] Starting subtest: ts-continuation-dpms-suspend
[411.435147] Starting dynamic subtest: pipe-A-eDP-1
[428.630986] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.001s)
[428.644038] Starting dynamic subtest: pipe-D-eDP-1
[446.646118] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s)
[446.649007] Subtest ts-continuation-dpms-suspend: SUCCESS (4.484s)
[447.442287] [078/133] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[447.545975] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[447.550875] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[447.642958] [079/133] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[447.738992] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[451.317967] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.585s)
[452.457376] [080/133] (563s left) kms_legacy_colorkey (invalid-plane)
[452.550158] Starting subtest: invalid-plane
[452.552783] Starting dynamic subtest: zero-id
[452.555149] Dynamic subtest zero-id: SUCCESS (0.000s)
[452.564045] Starting dynamic subtest: outrange-id
[452.566416] Dynamic subtest outrange-id: SUCCESS (0.000s)
[452.568718] Subtest invalid-plane: SUCCESS (0.001s)
[452.625337] [081/133] (563s left) perf_pmu (most-busy-idle-check-all)
[452.669817] Starting subtest: most-busy-idle-check-all
[452.671880] Starting dynamic subtest: rcs0
[453.382924] Dynamic subtest rcs0: FAIL (0.641s)
[453.392654] Starting dynamic subtest: bcs0
[454.629147] Dynamic subtest bcs0: SUCCESS (1.319s)
[454.651912] Starting dynamic subtest: vcs0
[456.611124] Dynamic subtest vcs0: SUCCESS (1.979s)
[456.623818] Starting dynamic subtest: vcs1
[458.659570] Dynamic subtest vcs1: SUCCESS (2.046s)
[458.672148] Starting dynamic subtest: vecs0
[460.642797] Dynamic subtest vecs0: SUCCESS (1.980s)
[460.655064] Starting dynamic subtest: ccs0
[462.626872] Dynamic subtest ccs0: SUCCESS (1.981s)
[462.629932] Subtest most-busy-idle-check-all: FAIL (9.964s)
[462.737397] [082/133] (553s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[462.946743] Starting subtest: cursor-rapid-movement-128x128
[462.949141] Starting dynamic subtest: pipe-A-eDP-1
[463.486621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.535s)
[463.511738] Starting dynamic subtest: pipe-D-eDP-1
[464.683596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s)
[464.686141] Subtest cursor-rapid-movement-128x128: SUCCESS (1.736s)
[465.521680] [083/133] (550s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[465.616415] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[465.621626] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[465.716470] [084/133] (550s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[465.777990] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[465.783538] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[465.971039] [085/133] (550s left) kms_dsc (dsc-with-output-formats)
[466.068053] Starting subtest: dsc-with-output-formats
[466.094635] Subtest dsc-with-output-formats: SKIP (0.001s)
[466.139357] [086/133] (550s left) kms_psr (psr-cursor-render)
[466.236890] Starting subtest: psr-cursor-render
[466.239620] Starting dynamic subtest: eDP-1
[467.938852] Dynamic subtest eDP-1: SUCCESS (1.701s)
[467.941441] Subtest psr-cursor-render: SUCCESS (1.702s)
[468.788161] [087/133] (547s left) gem_mmap_wc (write-prefaulted)
[468.850813] Subtest write-prefaulted: SKIP (0.000s)
[468.926621] [088/133] (547s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[469.020781] Starting subtest: bad-aux-stride-yf-tiled-ccs
[469.023170] Starting dynamic subtest: pipe-A-eDP-1
[469.047366] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[469.057042] Starting dynamic subtest: pipe-B-eDP-1
[469.078912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[469.087319] Starting dynamic subtest: pipe-C-eDP-1
[469.111879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[469.120127] Starting dynamic subtest: pipe-D-eDP-1
[469.145654] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[469.150770] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[471.268661] [089/133] (545s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[471.358171] Starting subtest: fbc-psr2-cursor-plane-onoff
[471.360947] Starting dynamic subtest: eDP-1
[471.365921] Dynamic subtest eDP-1: SKIP (0.000s)
[471.370944] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[471.430941] [090/133] (544s left) kms_addfb_basic (addfb25-bad-modifier)
[471.520204] Starting subtest: addfb25-bad-modifier
[471.522946] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[471.614020] [091/133] (544s left) gen9_exec_parse (basic-rejected)
[471.666941] Subtest basic-rejected: SKIP (0.000s)
[471.742500] [092/133] (544s left) kms_color_pipeline (plane-ctm3x4)
[471.849153] Starting subtest: plane-ctm3x4
[471.995123] Starting dynamic subtest: pipe-A-plane-0
[472.300954] Dynamic subtest pipe-A-plane-0: FAIL (0.119s)
[472.313152] Starting dynamic subtest: pipe-A-plane-1
[472.524542] Dynamic subtest pipe-A-plane-1: FAIL (0.143s)
[472.534159] Starting dynamic subtest: pipe-A-plane-2
[472.775880] Dynamic subtest pipe-A-plane-2: FAIL (0.143s)
[473.555024] Starting dynamic subtest: pipe-B-plane-0
[473.982916] Dynamic subtest pipe-B-plane-0: FAIL (0.140s)
[473.991815] Starting dynamic subtest: pipe-B-plane-1
[474.343523] Dynamic subtest pipe-B-plane-1: FAIL (0.155s)
[474.353923] Starting dynamic subtest: pipe-B-plane-2
[474.687659] Dynamic subtest pipe-B-plane-2: FAIL (0.682s)
[475.723999] Starting dynamic subtest: pipe-C-plane-0
[476.250294] Dynamic subtest pipe-C-plane-0: FAIL (0.118s)
[476.260835] Starting dynamic subtest: pipe-C-plane-1
[476.683862] Dynamic subtest pipe-C-plane-1: FAIL (0.693s)
[476.693726] Starting dynamic subtest: pipe-C-plane-2
[477.110526] Dynamic subtest pipe-C-plane-2: FAIL (0.144s)
[477.836160] Starting dynamic subtest: pipe-D-plane-0
[478.397198] Dynamic subtest pipe-D-plane-0: FAIL (0.106s)
[478.406277] Starting dynamic subtest: pipe-D-plane-1
[478.912636] Dynamic subtest pipe-D-plane-1: FAIL (0.596s)
[478.922284] Starting dynamic subtest: pipe-D-plane-2
[479.417433] Dynamic subtest pipe-D-plane-2: FAIL (0.624s)
[479.456767] Subtest plane-ctm3x4: FAIL (7.608s)
[480.307541] [093/133] (536s left) perf (enable-disable)
[480.402945] Starting subtest: enable-disable
[480.405530] Starting dynamic subtest: 0-rcs0
[482.650049] Dynamic subtest 0-rcs0: SUCCESS (2.245s)
[482.659468] Starting dynamic subtest: 1-vcs1
[487.089975] Dynamic subtest 1-vcs1: SUCCESS (4.438s)
[487.092970] Subtest enable-disable: SUCCESS (6.685s)
[487.136981] [094/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[487.233977] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[487.238923] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[487.335438] [095/133] (529s left) gem_exec_whisper (basic-contexts-all)
[487.400567] Starting subtest: basic-contexts-all
[498.562746] Subtest basic-contexts-all: SUCCESS (11.160s)
[498.751913] [096/133] (517s left) gem_userptr_blits (userfault)
[498.808788] Starting subtest: userfault
[498.811182] Subtest userfault: SUCCESS (0.009s)
[498.947029] [097/133] (517s left) gem_exec_balancer (bonded-false-hang)
[499.193805] Starting subtest: bonded-false-hang
[499.199417] Subtest bonded-false-hang: SKIP (0.000s)
[499.284012] [098/133] (517s left) gem_create (busy-create)
[499.361042] Starting subtest: busy-create
[499.363625] Starting dynamic subtest: smem0
[533.665902] Dynamic subtest smem0: SUCCESS (34.308s)
[533.668975] Subtest busy-create: SUCCESS (34.310s)
[533.852523] [099/133] (482s left) gem_exec_reloc (basic-write-gtt)
[533.919982] Subtest basic-write-gtt: SKIP (0.000s)
[533.986655] [100/133] (482s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[534.092123] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[534.119832] Starting dynamic subtest: pipe-A-plane-0
[534.419164] Dynamic subtest pipe-A-plane-0: SUCCESS (0.299s)
[534.430207] Starting dynamic subtest: pipe-A-plane-3
[534.652109] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[535.788072] Starting dynamic subtest: pipe-B-plane-0
[536.076446] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[536.086126] Starting dynamic subtest: pipe-B-plane-3
[536.309892] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[536.620268] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.530s)
[537.458473] [101/133] (479s left) kms_flip (2x-flip-vs-fences-interruptible)
[537.563921] Starting subtest: 2x-flip-vs-fences-interruptible
[537.569003] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[537.642825] [102/133] (479s left) kms_joiner (basic-ultra-joiner)
[537.744769] Starting subtest: basic-ultra-joiner
[537.749600] Subtest basic-ultra-joiner: SKIP (0.000s)
[537.811157] [103/133] (479s left) gem_mmap_wc (read)
[537.869956] Subtest read: SKIP (0.000s)
[537.935734] [104/133] (479s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[538.034925] Starting subtest: x-tiled-32bpp-rotate-180
[539.405057] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.368s)
[539.541420] [105/133] (477s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[539.649473] Starting subtest: cursor-vs-flip-atomic
[569.031997] Subtest cursor-vs-flip-atomic: SUCCESS (29.379s)
[569.895495] [106/133] (447s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[569.986122] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[569.988851] Starting dynamic subtest: pipe-A-eDP-1
[570.044289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.060s)
[570.057017] Starting dynamic subtest: pipe-B-eDP-1
[570.104452] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[570.116993] Starting dynamic subtest: pipe-C-eDP-1
[570.165294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.059s)
[570.179840] Starting dynamic subtest: pipe-D-eDP-1
[570.224123] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[570.226662] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.241s)
[572.482932] [107/133] (444s left) gem_eio (reset-stress)
[572.704053] Starting subtest: reset-stress
[572.706547] Starting dynamic subtest: render
[577.571495] Dynamic subtest render: SUCCESS (4.864s)
[577.589158] Starting dynamic subtest: bsd1
[595.193776] Dynamic subtest bsd1: SUCCESS (17.621s)
[595.210009] Starting dynamic subtest: bsd2
[613.166564] Dynamic subtest bsd2: SUCCESS (17.971s)
[613.181938] Starting dynamic subtest: blt
[613.186919] Dynamic subtest blt: SKIP (0.000s)
[613.197177] Starting dynamic subtest: vebox
[631.170074] Dynamic subtest vebox: SUCCESS (18.003s)
[631.172640] Subtest reset-stress: SUCCESS (58.465s)
[632.680566] [108/133] (384s left) kms_plane (plane-position-hole)
[632.774333] Starting subtest: plane-position-hole
[633.302387] Starting dynamic subtest: pipe-A-plane-1
[634.560145] Dynamic subtest pipe-A-plane-1: SUCCESS (1.257s)
[634.571184] Starting dynamic subtest: pipe-A-plane-2
[635.893961] Dynamic subtest pipe-A-plane-2: SUCCESS (1.330s)
[635.904525] Starting dynamic subtest: pipe-A-plane-3
[637.217643] Dynamic subtest pipe-A-plane-3: SUCCESS (1.324s)
[637.229541] Starting dynamic subtest: pipe-A-plane-4
[638.552239] Dynamic subtest pipe-A-plane-4: SUCCESS (1.336s)
[638.572000] Starting dynamic subtest: pipe-A-plane-5
[638.582480] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[639.783073] Starting dynamic subtest: pipe-B-plane-1
[641.117352] Dynamic subtest pipe-B-plane-1: SUCCESS (1.340s)
[641.127905] Starting dynamic subtest: pipe-B-plane-2
[642.468140] Dynamic subtest pipe-B-plane-2: SUCCESS (1.354s)
[642.478123] Starting dynamic subtest: pipe-B-plane-3
[643.774780] Dynamic subtest pipe-B-plane-3: SUCCESS (1.306s)
[643.784432] Starting dynamic subtest: pipe-B-plane-4
[645.116538] Dynamic subtest pipe-B-plane-4: SUCCESS (1.340s)
[645.126854] Starting dynamic subtest: pipe-B-plane-5
[645.143381] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[645.145703] Subtest plane-position-hole: SUCCESS (12.369s)
[645.978917] [109/133] (371s left) kms_flip (nonblocking-read)
[646.074079] Starting subtest: nonblocking-read
[646.076602] Subtest nonblocking-read: SUCCESS (0.000s)
[646.157545] [110/133] (371s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[646.251998] Starting subtest: fbcpsr-shrfb-scaledprimary
[652.120248] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.872s)
[652.242941] [111/133] (365s left) template (a)
[652.303964] Starting subtest: A
[652.306275] Subtest A: SUCCESS (0.000s)
[652.393824] [112/133] (364s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[652.490889] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[652.495623] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[652.582397] [113/133] (364s left) gem_exec_fence (syncobj-timeline-wait)
[653.121602] Starting subtest: syncobj-timeline-wait
[654.645856] Subtest syncobj-timeline-wait: SUCCESS (1.524s)
[656.725398] [114/133] (360s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[656.838938] Starting subtest: psr2-overlay-plane-update-continuous-sf
[656.841806] Starting dynamic subtest: pipe-A-eDP-1
[657.958626] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.126s)
[657.969218] Starting dynamic subtest: pipe-B-eDP-1
[659.681002] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.722s)
[659.683832] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.851s)
[660.481829] [115/133] (356s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[660.607128] Starting subtest: cursorA-vs-flipB-toggle
[660.612012] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[660.753610] [116/133] (356s left) kms_plane_scaling (planes-upscale-factor-0-25)
[660.849904] Starting subtest: planes-upscale-factor-0-25
[660.852587] Starting dynamic subtest: pipe-A
[660.910347] Dynamic subtest pipe-A: SUCCESS (0.062s)
[660.926024] Starting dynamic subtest: pipe-B
[662.014950] Dynamic subtest pipe-B: SUCCESS (1.104s)
[662.025364] Starting dynamic subtest: pipe-C
[663.131925] Dynamic subtest pipe-C: SUCCESS (1.113s)
[663.142829] Starting dynamic subtest: pipe-D
[664.258119] Dynamic subtest pipe-D: SUCCESS (1.128s)
[664.260701] Subtest planes-upscale-factor-0-25: SUCCESS (3.412s)
[665.422275] [117/133] (352s left) i915_pm_freq_api (freq-basic-api)
[665.501148] Starting subtest: freq-basic-api
[665.503505] Starting dynamic subtest: gt0
[665.506153] Dynamic subtest gt0: SUCCESS (0.006s)
[665.516424] Starting dynamic subtest: gt1
[665.519117] Dynamic subtest gt1: SUCCESS (0.004s)
[665.521913] Subtest freq-basic-api: SUCCESS (0.013s)
[665.593973] [118/133] (351s left) kms_cursor_crc (cursor-onscreen-128x42)
[665.835938] Starting subtest: cursor-onscreen-128x42
[665.886643] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[666.094324] [119/133] (351s left) api_intel_bb (bb-with-allocator)
[666.148877] Starting subtest: bb-with-allocator
[666.152942] Subtest bb-with-allocator: SUCCESS (0.007s)
[666.279040] [120/133] (351s left) gem_mmap_wc (copy)
[666.346542] Subtest copy: SKIP (0.000s)
[666.406018] [121/133] (351s left) gem_ctx_param (invalid-param-get)
[666.461643] Starting subtest: invalid-param-get
[666.463873] Subtest invalid-param-get: SUCCESS (0.002s)
[666.569522] [122/133] (351s left) kms_flip (flip-vs-suspend-interruptible)
[666.664677] Starting subtest: flip-vs-suspend-interruptible
[666.666768] Starting dynamic subtest: A-eDP1
[700.091302] Dynamic subtest A-eDP1: SUCCESS (4.147s)
[700.106591] Starting dynamic subtest: B-eDP1
[749.102696] Dynamic subtest B-eDP1: SUCCESS (4.518s)
[749.115961] Starting dynamic subtest: C-eDP1
[798.110683] Dynamic subtest C-eDP1: SUCCESS (4.505s)
[798.127995] Starting dynamic subtest: D-eDP1
[847.100130] Dynamic subtest D-eDP1: SUCCESS (4.525s)
[847.103303] Subtest flip-vs-suspend-interruptible: SUCCESS (17.706s)
[848.289167] [123/133] (169s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[848.418998] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[848.423988] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[848.504668] [124/133] (169s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[848.610060] Starting subtest: fbcpsr-tiling-4
[855.549323] Subtest fbcpsr-tiling-4: SUCCESS (6.935s)
[855.671568] [125/133] (162s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[855.839014] Starting subtest: pr-primary-plane-update-sf-dmg-area
[855.845137] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[855.906730] [126/133] (162s left) gem_partial_pwrite_pread (reads-snoop)
[855.971824] Subtest reads-snoop: SKIP (0.000s)
[856.049822] [127/133] (161s left) kms_plane_alpha_blend (coverage-7efc)
[856.138042] Starting subtest: coverage-7efc
[856.425264] Starting dynamic subtest: pipe-A-eDP-1
[856.990527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[857.018133] Starting dynamic subtest: pipe-D-eDP-1
[858.302162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[858.305290] Subtest coverage-7efc: SUCCESS (2.165s)
[859.161523] [128/133] (158s left) fbdev (unaligned-write)
[859.212258] Starting subtest: unaligned-write
[859.313110] Subtest unaligned-write: SUCCESS (0.100s)
[859.378705] [129/133] (158s left) i915_selftest (live)
[861.942145] Starting subtest: live
[861.944882] Starting dynamic subtest: sanitycheck
[867.029761] Dynamic subtest sanitycheck: SUCCESS (5.085s)
[867.040045] Starting dynamic subtest: uncore
[870.517953] Dynamic subtest uncore: SUCCESS (3.486s)
[870.526800] Starting dynamic subtest: workarounds
[874.463954] Dynamic subtest workarounds: SUCCESS (3.943s)
[874.474246] Starting dynamic subtest: gt_engines
[878.432645] Dynamic subtest gt_engines: SUCCESS (3.966s)
[878.443100] Starting dynamic subtest: gt_timelines
[897.523236] Dynamic subtest gt_timelines: SUCCESS (19.092s)
[897.533607] Starting dynamic subtest: gt_contexts
[902.678993] Dynamic subtest gt_contexts: SUCCESS (5.154s)
[902.689136] Starting dynamic subtest: gt_lrc
[907.758729] Dynamic subtest gt_lrc: SUCCESS (5.077s)
[907.767890] Starting dynamic subtest: gt_mocs
[911.493276] Dynamic subtest gt_mocs: SUCCESS (3.732s)
[911.503506] Starting dynamic subtest: gt_pm
[919.102244] Dynamic subtest gt_pm: SUCCESS (7.606s)
[919.112231] Starting dynamic subtest: gt_heartbeat
[924.264246] Dynamic subtest gt_heartbeat: SUCCESS (5.161s)
[924.273253] Starting dynamic subtest: gt_tlb
[934.418553] Dynamic subtest gt_tlb: SUCCESS (10.150s)
[934.433578] Starting dynamic subtest: requests
[946.768555] Dynamic subtest requests: SUCCESS (12.347s)
[946.777784] Starting dynamic subtest: migrate
[953.326629] Dynamic subtest migrate: SUCCESS (6.558s)
[953.335604] Starting dynamic subtest: active
[958.420185] Dynamic subtest active: SUCCESS (5.092s)
[958.430019] Starting dynamic subtest: objects
[962.435288] Dynamic subtest objects: SUCCESS (4.014s)
[962.444750] Starting dynamic subtest: mman
[966.596043] Dynamic subtest mman: SUCCESS (4.160s)
[966.606121] Starting dynamic subtest: dmabuf
[970.154572] Dynamic subtest dmabuf: SUCCESS (3.557s)
[970.164396] Starting dynamic subtest: vma
[973.718841] Dynamic subtest vma: SUCCESS (3.563s)
[973.727519] Starting dynamic subtest: coherency
[978.429893] Dynamic subtest coherency: SUCCESS (4.708s)
[978.441731] Starting dynamic subtest: gtt
[988.594536] Dynamic subtest gtt: SUCCESS (10.161s)
[988.605104] Starting dynamic subtest: gem
[995.024992] Dynamic subtest gem: SUCCESS (6.428s)
[995.035124] Starting dynamic subtest: evict
[1001.395841] Dynamic subtest evict: SUCCESS (6.369s)
[1001.405720] Starting dynamic subtest: hugepages
[1010.900022] Dynamic subtest hugepages: SUCCESS (9.501s)
[1010.910348] Starting dynamic subtest: gem_contexts
[1038.968799] Dynamic subtest gem_contexts: SUCCESS (28.064s)
[1038.979272] Starting dynamic subtest: client
[1042.526893] Dynamic subtest client: SUCCESS (3.556s)
[1042.537108] Starting dynamic subtest: gem_migrate
[1046.071578] Dynamic subtest gem_migrate: SUCCESS (3.542s)
[1046.082169] Starting dynamic subtest: reset
[1051.274634] Dynamic subtest reset: SUCCESS (5.201s)
[1051.282415] Starting dynamic subtest: memory_region
[1054.926552] Dynamic subtest memory_region: SUCCESS (3.649s)
[1054.937035] Starting dynamic subtest: hangcheck
[1068.425087] Dynamic subtest hangcheck: SUCCESS (13.494s)
[1068.438721] Starting dynamic subtest: execlists
[1073.556677] Dynamic subtest execlists: SUCCESS (5.130s)
[1073.565425] Starting dynamic subtest: ring_submission
[1077.050558] Dynamic subtest ring_submission: SUCCESS (3.492s)
[1077.060843] Starting dynamic subtest: perf
[1080.624499] Dynamic subtest perf: SUCCESS (3.573s)
[1080.632915] Starting dynamic subtest: slpc
[1093.560548] Dynamic subtest slpc: SUCCESS (12.936s)
[1093.570793] Starting dynamic subtest: guc
[1098.323942] Dynamic subtest guc: SUCCESS (4.762s)
[1098.340924] Starting dynamic subtest: guc_multi_lrc
[1103.464213] Dynamic subtest guc_multi_lrc: SUCCESS (5.139s)
[1103.473624] Starting dynamic subtest: guc_hang
[1107.725307] Dynamic subtest guc_hang: SUCCESS (4.259s)
[1107.735876] Starting dynamic subtest: late_gt_pm
[1111.287057] Dynamic subtest late_gt_pm: SUCCESS (3.561s)
[1111.289903] Subtest live: SUCCESS (249.326s)
[1111.309730] Overall timeout time exceeded, stopping.
[1111.319056] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1111.319754] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[1111.319890] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: sysfs_timeslice_duration
results: parsing output: 7/ for test: gem_partial_pwrite_pread
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_pm_dc
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_async_flips
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: gem_mmap_wc
results: parsing output: 29/ for test: gem_exec_params
results: parsing output: 30/ for test: kms_rotation_crc
results: parsing output: 31/ for test: kms_chamelium_frames
results: parsing output: 32/ for test: gen3_render_mixed_blits
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: dumb_buffer
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_rotation_crc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_setmode
results: parsing output: 49/ for test: gem_exec_fence
results: parsing output: 50/ for test: kms_atomic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_partial_pwrite_pread
results: parsing output: 53/ for test: core_auth
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_spin_batch
results: parsing output: 59/ for test: gem_flink_basic
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_exec_async
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: gem_lmem_swapping
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_sequence
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_content_protection
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_legacy_colorkey
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_render_copy
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_mmap_wc
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: kms_color_pipeline
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: gem_userptr_blits
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: gem_create
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: template
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_fence
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_plane_scaling
results: parsing output: 116/ for test: i915_pm_freq_api
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: gem_mmap_wc
results: parsing output: 120/ for test: gem_ctx_param
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_plane
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_partial_pwrite_pread
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: fbdev
results: parsing output: 128/ for test: i915_selftest
results: parsing output: 129/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 131/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 132/ for test: kms_cursor_legacy
results: no output, setting notrun
Done.