[102.778792] Initializing watchdogs
[102.778928]   /dev/watchdog0
[102.796288] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[102.801102] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[102.803449] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[102.806955] [001/156] (960s left) syncobj_timeline (single-wait-for-submit-signaled)
[102.884856] Starting subtest: single-wait-for-submit-signaled
[102.887162] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[102.964013] [002/156] (960s left) kms_dsc (dsc-with-formats)
[103.049095] Starting subtest: dsc-with-formats
[103.087927] Subtest dsc-with-formats: SKIP (0.001s)
[103.129361] [003/156] (960s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[103.207439] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[103.211768] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[103.313958] [004/156] (960s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[103.397815] Starting subtest: psr-rgb565-draw-mmap-wc
[110.185911] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.793s)
[110.282818] [005/156] (953s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[110.373832] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[111.406095] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.034s)
[111.538886] [006/156] (951s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[111.623069] Starting subtest: y-tiled-8bpp-rotate-180
[111.627142] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[111.711788] [007/156] (951s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[111.792768] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[111.796118] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[111.876562] [008/156] (951s left) kms_psr (fbc-pr-cursor-render)
[111.950047] Starting subtest: fbc-pr-cursor-render
[111.953507] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[112.022272] [009/156] (951s left) gem_exec_gttfill (engines)
[112.079353] Starting subtest: engines
[112.081428] Starting dynamic subtest: rcs0
[134.888612] Dynamic subtest rcs0: SUCCESS (22.806s)
[134.898413] Starting dynamic subtest: bcs0
[158.148854] Dynamic subtest bcs0: SUCCESS (23.259s)
[158.157951] Starting dynamic subtest: vcs0
[181.375832] Dynamic subtest vcs0: SUCCESS (23.224s)
[181.384512] Starting dynamic subtest: vcs1
[204.626434] Dynamic subtest vcs1: SUCCESS (23.248s)
[204.637653] Starting dynamic subtest: vecs0
[227.920799] Dynamic subtest vecs0: SUCCESS (23.292s)
[227.930569] Starting dynamic subtest: ccs0
[251.148581] Dynamic subtest ccs0: SUCCESS (23.226s)
[251.151061] Subtest engines: SUCCESS (139.061s)
[251.334216] [010/156] (812s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[251.479761] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[251.483721] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[251.580691] [011/156] (812s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[251.656070] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[251.660317] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[251.745064] [012/156] (811s left) drm_read (fault-buffer)
[251.891088] Starting subtest: fault-buffer
[251.893459] Subtest fault-buffer: SUCCESS (0.000s)
[252.007059] [013/156] (811s left) kms_pm_rpm (modeset-non-lpsp-stress)
[253.501451] Starting subtest: modeset-non-lpsp-stress
[254.651038] Subtest modeset-non-lpsp-stress: SKIP (1.147s)
[255.026426] [014/156] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[255.109926] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[255.114522] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[255.202777] [015/156] (808s left) gem_exec_flush (basic-wb-ro-default)
[255.272310] Starting subtest: basic-wb-ro-default
[260.741593] Subtest basic-wb-ro-default: SUCCESS (5.470s)
[260.939421] [016/156] (802s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-render)
[261.023186] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-render
[261.027362] Subtest hdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[261.101765] [017/156] (802s left) i915_pm_rps (min-max-config-idle)
[261.165629] Starting subtest: min-max-config-idle
[261.170363] Subtest min-max-config-idle: SKIP (0.000s)
[261.260823] [018/156] (802s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[261.342079] Starting subtest: fbchdr-rgb565-draw-blt
[261.346764] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[261.423133] [019/156] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[261.500329] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[261.504990] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[261.612128] [020/156] (802s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[261.697997] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[261.702357] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[261.804228] [021/156] (802s left) kms_joiner (invalid-modeset-ultra-joiner)
[261.897880] Starting subtest: invalid-modeset-ultra-joiner
[261.901630] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[261.973550] [022/156] (802s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[262.056812] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[262.060183] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[262.160939] [023/156] (801s left) kms_lease (lease-unleased-connector)
[262.231498] Starting subtest: lease-unleased-connector
[262.233504] Starting dynamic subtest: pipe-A-eDP-1
[262.237892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[262.248306] Starting dynamic subtest: pipe-B-eDP-1
[262.250232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[262.262814] Starting dynamic subtest: pipe-C-eDP-1
[262.264641] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[262.272727] Starting dynamic subtest: pipe-D-eDP-1
[262.274548] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[262.276374] Subtest lease-unleased-connector: SUCCESS (0.031s)
[262.368561] [024/156] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[262.448908] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[269.230860] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.786s)
[269.394105] [025/156] (794s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[269.451222] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[269.553944] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[269.637026] [026/156] (794s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-onoff)
[269.723877] Starting subtest: fbchdr-2p-primscrn-spr-indfb-onoff
[269.728519] Subtest fbchdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[269.812406] [027/156] (794s left) kms_sequence (get-idle)
[269.897181] Starting subtest: get-idle
[269.899135] Starting dynamic subtest: pipe-A-eDP-1
[271.710921] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s)
[271.720494] Starting dynamic subtest: pipe-B-eDP-1
[274.223665] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.515s)
[274.233153] Starting dynamic subtest: pipe-C-eDP-1
[276.738183] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.512s)
[276.747805] Starting dynamic subtest: pipe-D-eDP-1
[279.171494] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[279.173903] Subtest get-idle: SUCCESS (9.274s)
[279.986073] [028/156] (784s left) gem_lmem_swapping (massive)
[280.027941] Subtest massive: SKIP (0.000s)
[280.071100] [029/156] (784s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[280.151972] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[284.617957] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.473s)
[285.776499] [030/156] (778s left) kms_psr (psr2-cursor-mmap-gtt)
[285.852127] Starting subtest: psr2-cursor-mmap-gtt
[285.854521] Starting dynamic subtest: eDP-1
[287.545705] Dynamic subtest eDP-1: SUCCESS (1.693s)
[287.548081] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.693s)
[288.426265] [031/156] (776s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[288.508317] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[288.512589] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[288.608049] [032/156] (775s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[288.692577] Starting subtest: pr-overlay-plane-update-continuous-sf
[288.696685] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[288.758661] [033/156] (775s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[288.813206] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[288.882425] [034/156] (775s left) kms_chamelium_hpd (dp-hpd-fast)
[289.239652] Subtest dp-hpd-fast: SKIP (0.000s)
[290.042915] [035/156] (774s left) kms_psr (psr2-sprite-plane-move)
[290.111183] Starting subtest: psr2-sprite-plane-move
[290.113537] Starting dynamic subtest: eDP-1
[291.896451] Dynamic subtest eDP-1: SUCCESS (1.786s)
[291.898775] Subtest psr2-sprite-plane-move: SUCCESS (1.787s)
[292.737571] [036/156] (771s left) gem_userptr_blits (userfault)
[292.808188] Starting subtest: userfault
[292.810404] Subtest userfault: SUCCESS (0.006s)
[292.941688] [037/156] (771s left) perf_pmu (busy-idle)
[292.982412] Starting subtest: busy-idle
[292.984632] Starting dynamic subtest: rcs0
[293.667579] Dynamic subtest rcs0: SUCCESS (0.686s)
[293.680068] Starting dynamic subtest: bcs0
[294.328660] Dynamic subtest bcs0: SUCCESS (0.659s)
[294.340222] Starting dynamic subtest: vcs0
[296.253558] Dynamic subtest vcs0: SUCCESS (1.922s)
[296.265726] Starting dynamic subtest: vcs1
[298.237413] Dynamic subtest vcs1: SUCCESS (1.983s)
[298.248164] Starting dynamic subtest: vecs0
[300.220820] Dynamic subtest vecs0: SUCCESS (1.982s)
[300.231712] Starting dynamic subtest: ccs0
[300.881285] Dynamic subtest ccs0: SUCCESS (0.660s)
[300.884650] Subtest busy-idle: SUCCESS (7.900s)
[300.977906] [038/156] (763s left) gem_render_tiled_blits (basic)
[301.038644] Subtest basic: SKIP (0.000s)
[301.101917] [039/156] (763s left) gem_request_retire (retire-vma-not-inactive)
[301.154697] Starting subtest: retire-vma-not-inactive
[301.211118] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[301.345932] [040/156] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[301.438779] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[301.443187] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[301.532528] [041/156] (763s left) gem_ppgtt (shrink-vs-evict-pinned)
[301.592971] Starting subtest: shrink-vs-evict-pinned
[307.225588] Subtest shrink-vs-evict-pinned: SUCCESS (5.633s)
[307.317098] [042/156] (757s left) gem_exec_fence (submit67)
[307.490053] Starting subtest: submit67
[307.494249] Subtest submit67: SKIP (0.000s)
[309.306804] [FACT gem_exec_fence (submit67)] new: kernel.kmod_is_loaded.vgem: true
[309.310649] [043/156] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[309.396770] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[309.401252] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[309.500580] [044/156] (755s left) gem_exec_schedule (pi-shared-iova)
[309.676658] Starting subtest: pi-shared-iova
[309.678719] Starting dynamic subtest: rcs0
[309.745271] Dynamic subtest rcs0: SUCCESS (0.071s)
[309.758265] Starting dynamic subtest: vcs0
[309.809578] Dynamic subtest vcs0: SUCCESS (0.064s)
[309.818901] Starting dynamic subtest: vcs1
[309.866064] Dynamic subtest vcs1: SUCCESS (0.055s)
[309.877738] Starting dynamic subtest: vecs0
[309.911779] Dynamic subtest vecs0: SUCCESS (0.045s)
[309.921944] Starting dynamic subtest: ccs0
[309.967662] Dynamic subtest ccs0: SUCCESS (0.055s)
[309.969992] Subtest pi-shared-iova: SUCCESS (0.295s)
[311.321437] [045/156] (753s left) gem_exec_flush (basic-wb-pro-default)
[311.391241] Starting subtest: basic-wb-pro-default
[316.846948] Subtest basic-wb-pro-default: SUCCESS (5.456s)
[317.032288] [046/156] (748s left) gem_exec_balancer (indices)
[317.099064] Starting subtest: indices
[319.195910] Subtest indices: SUCCESS (2.097s)
[319.510414] [047/156] (745s left) gem_ctx_engines (invalid-engines)
[319.575551] Starting subtest: invalid-engines
[319.588399] Subtest invalid-engines: SUCCESS (0.012s)
[319.834421] [048/156] (745s left) gem_ctx_shared (exec-shared-gtt)
[319.886960] Starting subtest: exec-shared-gtt
[319.889841] Starting dynamic subtest: rcs0
[319.898760] Dynamic subtest rcs0: SUCCESS (0.012s)
[319.908058] Starting dynamic subtest: bcs0
[319.910316] Dynamic subtest bcs0: SUCCESS (0.010s)
[319.919405] Starting dynamic subtest: vcs0
[319.921582] Dynamic subtest vcs0: SUCCESS (0.010s)
[319.935725] Starting dynamic subtest: vcs1
[319.938215] Dynamic subtest vcs1: SUCCESS (0.008s)
[319.954382] Starting dynamic subtest: vecs0
[319.956598] Dynamic subtest vecs0: SUCCESS (0.008s)
[319.965595] Starting dynamic subtest: ccs0
[319.967669] Dynamic subtest ccs0: SUCCESS (0.007s)
[319.969767] Subtest exec-shared-gtt: SUCCESS (0.058s)
[320.134067] [049/156] (745s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[320.184825] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[320.189528] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[320.369284] [050/156] (744s left) vgem_basic (dmabuf-export)
[320.409980] Starting subtest: dmabuf-export
[320.438247] Subtest dmabuf-export: SUCCESS (0.031s)
[320.540087] [051/156] (744s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[320.622804] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[320.625074] Starting dynamic subtest: pipe-A-eDP-1
[320.647165] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.657173] Starting dynamic subtest: pipe-B-eDP-1
[320.678106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.687778] Starting dynamic subtest: pipe-C-eDP-1
[320.710657] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.721188] Starting dynamic subtest: pipe-D-eDP-1
[320.743623] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.747729] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[322.914793] [052/156] (742s left) kms_rotation_crc (bad-tiling)
[322.998096] Starting subtest: bad-tiling
[323.002386] Subtest bad-tiling: SKIP (0.001s)
[323.067830] [053/156] (742s left) syncobj_wait (reset-signaled)
[323.125956] Starting subtest: reset-signaled
[323.128189] Subtest reset-signaled: SUCCESS (0.000s)
[323.224311] [054/156] (742s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[323.307209] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[323.311599] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[323.386750] [055/156] (742s left) kms_invalid_mode (bad-hsync-end)
[323.466581] Starting subtest: bad-hsync-end
[323.468901] Starting dynamic subtest: pipe-A-eDP-1
[323.759431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[323.775861] Starting dynamic subtest: pipe-B-eDP-1
[323.778716] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[323.792869] Starting dynamic subtest: pipe-C-eDP-1
[323.795043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[323.807661] Starting dynamic subtest: pipe-D-eDP-1
[323.809959] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[323.812331] Subtest bad-hsync-end: SUCCESS (0.299s)
[324.642346] [056/156] (740s left) kms_chamelium_frames (hdmi-crc-single)
[325.011836] Subtest hdmi-crc-single: SKIP (0.000s)
[325.837126] [057/156] (739s left) fbdev (nullptr)
[325.887467] Starting subtest: nullptr
[325.889879] Subtest nullptr: SUCCESS (0.000s)
[325.945021] [058/156] (739s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[326.035031] Starting subtest: fbc-farfromfence-mmap-gtt
[326.039262] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[326.146515] [059/156] (739s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[326.220755] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[326.223058] Starting dynamic subtest: pipe-A-eDP-1
[326.245967] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[326.257118] Starting dynamic subtest: pipe-B-eDP-1
[326.278597] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[326.287745] Starting dynamic subtest: pipe-C-eDP-1
[326.308802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[326.319039] Starting dynamic subtest: pipe-D-eDP-1
[326.340327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[326.344638] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[328.501511] [060/156] (737s left) kms_cursor_crc (cursor-offscreen-256x85)
[328.724596] Starting subtest: cursor-offscreen-256x85
[328.771186] Subtest cursor-offscreen-256x85: SKIP (0.042s)
[328.937655] [061/156] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[329.027126] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[335.595262] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.573s)
[335.742531] [062/156] (729s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render)
[335.824206] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render
[335.828237] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[335.923911] [063/156] (729s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[336.008429] Starting subtest: yf-tiled-64bpp-rotate-90
[336.012609] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[336.099012] [064/156] (729s left) kms_async_flips (alternate-sync-async-flip-atomic)
[336.174637] Starting subtest: alternate-sync-async-flip-atomic
[336.552848] Starting dynamic subtest: pipe-A-eDP-1
[339.303589] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s)
[339.688277] Starting dynamic subtest: pipe-B-eDP-1
[342.432129] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[342.814110] Starting dynamic subtest: pipe-C-eDP-1
[345.568852] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[345.950857] Starting dynamic subtest: pipe-D-eDP-1
[348.718578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.777s)
[348.720870] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.545s)
[349.891688] [065/156] (715s left) gem_exec_await (wide-all)
[350.082961] Starting subtest: wide-all
[372.946084] Subtest wide-all: SUCCESS (22.862s)
[373.138475] [066/156] (692s left) gem_mmap_gtt (cpuset-big-copy-xy)
[373.235074] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[373.291050] [067/156] (692s left) kms_plane_scaling (invalid-parameters)
[373.370152] Starting subtest: invalid-parameters
[373.372375] Starting dynamic subtest: less-than-1-height-src
[373.385274] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[373.395523] Starting dynamic subtest: less-than-1-width-src
[373.397814] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[373.400180] Subtest invalid-parameters: SUCCESS (0.028s)
[373.494395] [068/156] (692s left) perf (low-oa-exponent-permissions)
[373.647017] Starting subtest: low-oa-exponent-permissions
[373.683415] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[373.732261] [069/156] (692s left) sysfs_preempt_timeout (invalid)
[373.793614] Starting subtest: invalid
[373.795978] Starting dynamic subtest: vecs0
[373.798465] Dynamic subtest vecs0: SUCCESS (0.000s)
[373.809621] Starting dynamic subtest: ccs0
[373.811908] Dynamic subtest ccs0: SUCCESS (0.000s)
[373.824144] Starting dynamic subtest: vcs0
[373.826367] Dynamic subtest vcs0: SUCCESS (0.000s)
[373.835829] Starting dynamic subtest: bcs0
[373.838203] Dynamic subtest bcs0: SUCCESS (0.000s)
[373.847254] Starting dynamic subtest: rcs0
[373.849148] Dynamic subtest rcs0: SUCCESS (0.000s)
[373.861758] Starting dynamic subtest: vcs1
[373.863873] Dynamic subtest vcs1: SUCCESS (0.000s)
[373.866021] Subtest invalid: SUCCESS (0.007s)
[373.902396] [070/156] (692s left) gem_exec_whisper (basic-contexts-forked)
[373.959605] Starting subtest: basic-contexts-forked
[398.626872] Subtest basic-contexts-forked: SUCCESS (24.662s)
[398.811308] [071/156] (667s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[398.903501] Starting subtest: fbc-rgb565-draw-render
[403.104244] Subtest fbc-rgb565-draw-render: SUCCESS (4.206s)
[404.289865] [072/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[404.381312] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[404.385748] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[404.478309] [073/156] (661s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[404.567602] Starting subtest: 4-tiled-16bpp-rotate-90
[404.586074] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.018s)
[404.699728] [074/156] (661s left) gen3_render_tiledy_blits
[404.803555] [075/156] (661s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[404.885986] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[404.890469] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[404.979151] [076/156] (661s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[405.058675] Starting subtest: crc-primary-basic-y-tiled-ccs
[405.060878] Starting dynamic subtest: pipe-A-eDP-1
[405.082152] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[405.092413] Starting dynamic subtest: pipe-B-eDP-1
[405.113094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[405.123468] Starting dynamic subtest: pipe-C-eDP-1
[405.144314] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[405.153435] Starting dynamic subtest: pipe-D-eDP-1
[405.176082] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[405.180180] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[407.338412] [077/156] (658s left) kms_cursor_crc (cursor-alpha-opaque)
[407.416803] Starting subtest: cursor-alpha-opaque
[407.419094] Starting dynamic subtest: pipe-A-eDP-1
[408.075217] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.658s)
[408.087792] Starting dynamic subtest: pipe-D-eDP-1
[409.328229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.250s)
[409.330332] Subtest cursor-alpha-opaque: SUCCESS (1.911s)
[410.224247] [078/156] (656s left) kms_selftest (drm_dp_mst_helper)
[410.265252] Starting subtest: drm_dp_mst_helper
[410.326590] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[410.429466] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.103s)
[410.441871] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[410.532515] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.102s)
[410.541980] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[410.645577] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.112s)
[410.647483] Subtest drm_dp_mst_helper: SUCCESS (0.379s)
[410.840973] [079/156] (655s left) kms_color_pipeline (plane-lut1d)
[410.920547] Starting subtest: plane-lut1d
[411.068810] Starting dynamic subtest: pipe-A-plane-0
[411.256445] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[411.267702] Starting dynamic subtest: pipe-A-plane-1
[411.445616] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[411.456344] Starting dynamic subtest: pipe-A-plane-2
[411.612882] Dynamic subtest pipe-A-plane-2: SUCCESS (0.165s)
[412.841068] Starting dynamic subtest: pipe-B-plane-0
[413.009130] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[413.019429] Starting dynamic subtest: pipe-B-plane-1
[413.177524] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[413.188641] Starting dynamic subtest: pipe-B-plane-2
[413.364632] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[414.533850] Starting dynamic subtest: pipe-C-plane-0
[414.658425] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[414.668224] Starting dynamic subtest: pipe-C-plane-1
[414.803302] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[414.813168] Starting dynamic subtest: pipe-C-plane-2
[414.947877] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[416.187706] Starting dynamic subtest: pipe-D-plane-0
[416.335253] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[416.345827] Starting dynamic subtest: pipe-D-plane-1
[416.490944] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[416.502473] Starting dynamic subtest: pipe-D-plane-2
[416.646269] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[416.937169] Subtest plane-lut1d: SUCCESS (6.015s)
[417.828997] [080/156] (648s left) syncobj_timeline (signal-array)
[417.885829] Starting subtest: signal-array
[417.887752] Subtest signal-array: SUCCESS (0.000s)
[417.993364] [081/156] (648s left) core_setmaster (master-drop-set-user)
[418.081578] Starting subtest: master-drop-set-user
[418.093650] Subtest master-drop-set-user: SUCCESS (0.012s)
[418.134415] [082/156] (648s left) kms_psr (fbc-psr-cursor-plane-onoff)
[418.204743] Starting subtest: fbc-psr-cursor-plane-onoff
[418.206845] Starting dynamic subtest: eDP-1
[418.210532] Dynamic subtest eDP-1: SKIP (0.000s)
[418.214411] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[418.284219] [083/156] (648s left) gem_exec_params (dr1-dirt)
[418.338630] Starting subtest: DR1-dirt
[418.340908] Subtest DR1-dirt: SUCCESS (0.000s)
[418.448048] [084/156] (648s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-pwrite)
[418.522280] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-pwrite
[418.526267] Subtest fbchdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[418.609223] [085/156] (648s left) gem_exec_schedule (promotion)
[418.685688] Starting subtest: promotion
[418.688065] Starting dynamic subtest: rcs0
[418.783827] Dynamic subtest rcs0: SUCCESS (0.107s)
[418.800030] Starting dynamic subtest: vcs0
[418.871872] Dynamic subtest vcs0: SUCCESS (0.086s)
[418.888130] Starting dynamic subtest: vcs1
[418.956829] Dynamic subtest vcs1: SUCCESS (0.083s)
[418.967317] Starting dynamic subtest: vecs0
[419.034219] Dynamic subtest vecs0: SUCCESS (0.076s)
[419.046181] Starting dynamic subtest: ccs0
[419.116659] Dynamic subtest ccs0: SUCCESS (0.081s)
[419.119196] Subtest promotion: SUCCESS (0.441s)
[420.317731] [086/156] (646s left) gem_mmap_offset (perf)
[420.374140] Starting subtest: perf
[420.376059] Starting dynamic subtest: smem0
[420.713822] Dynamic subtest smem0: SUCCESS (0.338s)
[420.716575] Subtest perf: SUCCESS (0.339s)
[420.816588] [087/156] (645s left) kms_flip (2x-plain-flip-interruptible)
[420.894714] Starting subtest: 2x-plain-flip-interruptible
[420.903659] Subtest 2x-plain-flip-interruptible: SKIP (0.008s)
[421.015603] [088/156] (645s left) kms_atomic (atomic-invalid-params)
[421.096852] Starting subtest: atomic-invalid-params
[421.099437] Starting dynamic subtest: pipe-A-eDP-1
[421.483363] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[421.485593] Subtest atomic-invalid-params: SUCCESS (0.387s)
[422.367999] [089/156] (644s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[422.438757] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[422.443080] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[422.511214] [090/156] (644s left) gem_exec_flush (basic-batch-kernel-default-uc)
[422.579349] Starting subtest: basic-batch-kernel-default-uc
[429.412871] Subtest basic-batch-kernel-default-uc: SUCCESS (6.835s)
[429.602625] [091/156] (637s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[429.706057] Starting subtest: basic-flip-after-cursor-legacy
[430.636391] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.930s)
[431.488826] [092/156] (635s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[431.544913] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[431.549421] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[431.727818] [093/156] (635s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[431.809657] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[431.814086] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[431.926149] [094/156] (635s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-blt)
[432.004626] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-blt
[432.008594] Subtest hdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[432.106546] [095/156] (634s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-render)
[432.194840] Starting subtest: psrhdr-rgb101010-draw-render
[432.199276] Subtest psrhdr-rgb101010-draw-render: SKIP (0.000s)
[432.301742] [096/156] (634s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[432.378562] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[433.380520] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[433.502245] [097/156] (633s left) api_intel_bb (object-noreloc-keep-cache-simple)
[433.567122] Starting subtest: object-noreloc-keep-cache-simple
[433.569736] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[433.658224] [098/156] (633s left) gem_mmap (bad-object)
[433.720399] Subtest bad-object: SKIP (0.000s)
[433.779692] [099/156] (633s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[433.858808] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[437.457207] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.602s)
[438.687433] [100/156] (628s left) kms_frontbuffer_tracking (psr-slowdraw)
[438.765549] Starting subtest: psr-slowdraw
[464.019035] Subtest psr-slowdraw: SUCCESS (25.257s)
[464.145289] [101/156] (603s left) i915_selftest (perf)
[467.575757] Starting subtest: perf
[467.578202] Starting dynamic subtest: engine_cs
[471.952952] Dynamic subtest engine_cs: SUCCESS (4.376s)
[471.961935] Starting dynamic subtest: request
[477.269997] Dynamic subtest request: SUCCESS (5.314s)
[477.280522] Starting dynamic subtest: migrate
[481.613840] Dynamic subtest migrate: SUCCESS (4.341s)
[481.624087] Starting dynamic subtest: region
[487.320507] Dynamic subtest region: SUCCESS (5.705s)
[487.323681] Subtest perf: SUCCESS (19.745s)
[487.350931] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[487.351833] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[487.354999] [102/156] (579s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[488.868600] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[511.816540] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.954s)
[511.956948] [FACT kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[511.958076] [FACT kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)] new: kernel.kmod_is_loaded.i915: true
[511.962075] [103/156] (555s left) kms_atomic_transition (plane-all-transition)
[512.047195] Starting subtest: plane-all-transition
[512.049166] Starting dynamic subtest: pipe-A-eDP-1
[514.542882] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[514.864719] Starting dynamic subtest: pipe-B-eDP-1
[518.109218] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s)
[518.420334] Subtest plane-all-transition: SUCCESS (6.372s)
[519.243098] [104/156] (548s left) gem_ctx_param (get-priority-new-ctx)
[519.304817] Starting subtest: get-priority-new-ctx
[519.307176] Subtest get-priority-new-ctx: SUCCESS (0.002s)
[519.397662] [105/156] (548s left) kms_psr (fbc-psr2-primary-blt)
[519.476120] Starting subtest: fbc-psr2-primary-blt
[519.478421] Starting dynamic subtest: eDP-1
[519.482830] Dynamic subtest eDP-1: SKIP (0.000s)
[519.487156] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[519.550477] [106/156] (547s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[519.639725] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[519.644143] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[519.707750] [107/156] (547s left) syncobj_basic (bad-handle-to-fd)
[519.757122] Starting subtest: bad-handle-to-fd
[519.759413] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[519.862648] [108/156] (547s left) vgem_slow (nohang)
[519.902423] Starting subtest: nohang
[530.332140] Subtest nohang: SUCCESS (10.429s)
[530.402243] [109/156] (537s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[530.488919] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[530.491101] Starting dynamic subtest: pipe-A
[531.537322] Dynamic subtest pipe-A: SUCCESS (1.050s)
[531.547564] Starting dynamic subtest: pipe-B
[533.638984] Dynamic subtest pipe-B: SUCCESS (2.101s)
[533.647747] Starting dynamic subtest: pipe-C
[534.841060] Dynamic subtest pipe-C: SUCCESS (1.200s)
[534.851686] Starting dynamic subtest: pipe-D
[536.070687] Dynamic subtest pipe-D: SUCCESS (1.229s)
[536.072963] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.583s)
[537.276878] [110/156] (530s left) gem_close_race (basic-threads)
[537.346054] Starting subtest: basic-threads
[538.690850] Subtest basic-threads: SUCCESS (1.344s)
[538.889758] [111/156] (528s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[538.964110] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[538.966462] Starting dynamic subtest: pipe-A-default-mode
[541.719488] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[541.721848] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.754s)
[542.542830] [112/156] (525s left) gem_spin_batch (spin-each)
[542.614084] Starting subtest: spin-each
[545.881131] Subtest spin-each: SUCCESS (3.260s)
[547.341054] [113/156] (520s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[547.437021] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[547.441395] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.533693] [114/156] (520s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[547.599509] Starting subtest: nonblocking-crc-frame-sequence
[547.601504] Starting dynamic subtest: pipe-A-eDP-1
[548.376489] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s)
[548.386974] Starting dynamic subtest: pipe-B-eDP-1
[549.793921] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.414s)
[549.803486] Starting dynamic subtest: pipe-C-eDP-1
[551.160832] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[551.172230] Starting dynamic subtest: pipe-D-eDP-1
[552.585806] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.421s)
[552.588364] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.986s)
[553.414042] [115/156] (514s left) gem_exec_balancer (parallel-keep-in-fence)
[553.667824] Starting subtest: parallel-keep-in-fence
[554.846702] Subtest parallel-keep-in-fence: SUCCESS (1.178s)
[554.967663] [116/156] (512s left) gem_ctx_persistence (legacy-engines-mixed-process)
[555.025286] Starting subtest: legacy-engines-mixed-process
[555.027715] Starting dynamic subtest: render
[556.237817] Dynamic subtest render: SUCCESS (1.212s)
[556.249857] Starting dynamic subtest: bsd1
[558.217575] Dynamic subtest bsd1: SUCCESS (1.975s)
[558.229368] Starting dynamic subtest: bsd2
[560.235583] Dynamic subtest bsd2: SUCCESS (2.019s)
[560.247718] Starting dynamic subtest: blt
[562.239953] Dynamic subtest blt: SUCCESS (2.003s)
[562.251316] Starting dynamic subtest: vebox
[564.234018] Dynamic subtest vebox: SUCCESS (1.992s)
[564.236535] Subtest legacy-engines-mixed-process: SUCCESS (9.210s)
[564.313119] [117/156] (503s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[564.400136] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[564.404593] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[564.494793] [118/156] (503s left) gen9_exec_parse (allowed-single)
[564.553997] Subtest allowed-single: SKIP (0.000s)
[564.624726] [119/156] (503s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[564.703987] Starting subtest: random-ccs-data-yf-tiled-ccs
[564.706269] Starting dynamic subtest: pipe-A-eDP-1
[564.729830] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[564.740860] Starting dynamic subtest: pipe-B-eDP-1
[564.764748] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[564.774207] Starting dynamic subtest: pipe-C-eDP-1
[564.798882] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[564.813327] Starting dynamic subtest: pipe-D-eDP-1
[564.837118] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[564.840989] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[566.955522] [120/156] (501s left) perf_pmu (all-busy-check-all)
[566.994854] Starting subtest: all-busy-check-all
[568.254052] Subtest all-busy-check-all: SUCCESS (1.258s)
[568.378514] [121/156] (499s left) gem_userptr_blits (coherency-unsync)
[568.448580] Subtest coherency-unsync: SKIP (0.000s)
[568.566566] [122/156] (499s left) kms_pm_rpm (basic-pci-d3-state)
[570.368846] Starting subtest: basic-pci-d3-state
[571.837974] Subtest basic-pci-d3-state: SUCCESS (1.472s)
[571.922685] [123/156] (496s left) i915_drm_fdinfo (basics)
[571.965041] Starting subtest: basics
[571.967341] Subtest basics: SUCCESS (0.000s)
[572.040222] [124/156] (496s left) kms_cursor_crc (cursor-sliding-64x64)
[572.199802] Starting subtest: cursor-sliding-64x64
[572.204659] Starting dynamic subtest: pipe-A-eDP-1
[575.425240] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.221s)
[575.457871] Starting dynamic subtest: pipe-D-eDP-1
[579.287758] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[579.289898] Subtest cursor-sliding-64x64: SUCCESS (7.086s)
[580.145748] [125/156] (488s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[580.230431] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[580.234577] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[580.325980] [126/156] (488s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[580.403149] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[580.405459] Starting dynamic subtest: pipe-A-default-mode
[581.606167] Dynamic subtest pipe-A-default-mode: SKIP (1.200s)
[581.610303] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.202s)
[581.748980] [127/156] (486s left) kms_addfb_basic (unused-handle)
[581.802710] Starting subtest: unused-handle
[581.804935] Subtest unused-handle: SUCCESS (0.000s)
[581.927702] [128/156] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[581.999907] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[582.003988] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[582.105808] [129/156] (486s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[582.172040] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[582.176301] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[582.244519] [130/156] (486s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[582.322141] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[582.325690] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[582.412459] [131/156] (486s left) kms_cursor_crc (cursor-random-128x42)
[582.607212] Starting subtest: cursor-random-128x42
[582.653750] Subtest cursor-random-128x42: SKIP (0.042s)
[582.850197] [132/156] (485s left) kms_flip (flip-vs-panning-interruptible)
[582.922110] Starting subtest: flip-vs-panning-interruptible
[582.924072] Starting dynamic subtest: A-eDP1
[591.695662] Dynamic subtest A-eDP1: SUCCESS (8.771s)
[591.710255] Starting dynamic subtest: B-eDP1
[600.420114] Dynamic subtest B-eDP1: SUCCESS (8.721s)
[600.431174] Starting dynamic subtest: C-eDP1
[609.149037] Dynamic subtest C-eDP1: SUCCESS (8.727s)
[609.162637] Starting dynamic subtest: D-eDP1
[617.871048] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[617.875492] Subtest flip-vs-panning-interruptible: SUCCESS (34.950s)
[619.043560] [133/156] (449s left) kms_vblank (ts-continuation-modeset-hang)
[619.139050] Starting subtest: ts-continuation-modeset-hang
[619.141309] Starting dynamic subtest: pipe-A-eDP-1
[646.021425] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.879s)
[646.037963] Starting dynamic subtest: pipe-D-eDP-1
[670.990801] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.965s)
[670.993184] Subtest ts-continuation-modeset-hang: SUCCESS (51.849s)
[671.795748] [134/156] (396s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[671.881570] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[671.886148] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[671.976583] [135/156] (396s left) gem_exec_parallel (contexts)
[672.041350] Starting subtest: contexts
[672.043625] Starting dynamic subtest: rcs0
[674.731469] Dynamic subtest rcs0: SUCCESS (2.689s)
[674.745863] Starting dynamic subtest: bcs0
[678.436139] Dynamic subtest bcs0: SUCCESS (3.702s)
[678.447397] Starting dynamic subtest: vcs0
[682.668991] Dynamic subtest vcs0: SUCCESS (4.230s)
[682.679181] Starting dynamic subtest: vcs1
[686.744989] Dynamic subtest vcs1: SUCCESS (4.073s)
[686.756427] Starting dynamic subtest: vecs0
[690.722908] Dynamic subtest vecs0: SUCCESS (3.976s)
[690.733916] Starting dynamic subtest: ccs0
[694.795587] Dynamic subtest ccs0: SUCCESS (4.069s)
[694.798024] Subtest contexts: SUCCESS (22.754s)
[695.032053] [136/156] (373s left) syncobj_timeline (multi-wait-available-signaled)
[695.114944] Starting subtest: multi-wait-available-signaled
[695.117365] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[695.360750] [137/156] (373s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[695.507973] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[695.512699] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[695.739444] [138/156] (373s left) syncobj_wait (multi-wait-signaled)
[695.906672] Starting subtest: multi-wait-signaled
[695.909110] Subtest multi-wait-signaled: SUCCESS (0.000s)
[696.003561] [139/156] (372s left) kms_big_fb (linear-32bpp-rotate-90)
[696.082732] Starting subtest: linear-32bpp-rotate-90
[696.107191] Subtest linear-32bpp-rotate-90: SKIP (0.020s)
[696.223885] [140/156] (372s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[696.302106] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[696.306236] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[696.401537] [141/156] (372s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[696.477224] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[696.481570] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[696.562564] [142/156] (372s left) perf_pmu (render-node-busy-idle)
[696.630807] Starting subtest: render-node-busy-idle
[696.633100] Starting dynamic subtest: rcs0
[697.326514] Dynamic subtest rcs0: SUCCESS (0.695s)
[697.339576] Starting dynamic subtest: bcs0
[697.993192] Dynamic subtest bcs0: SUCCESS (0.664s)
[698.006886] Starting dynamic subtest: vcs0
[699.261285] Dynamic subtest vcs0: SUCCESS (1.265s)
[699.275315] Starting dynamic subtest: vcs1
[701.245302] Dynamic subtest vcs1: SUCCESS (1.981s)
[701.258868] Starting dynamic subtest: vecs0
[703.229758] Dynamic subtest vecs0: SUCCESS (1.983s)
[703.243498] Starting dynamic subtest: ccs0
[703.896346] Dynamic subtest ccs0: SUCCESS (0.666s)
[703.898900] Subtest render-node-busy-idle: SUCCESS (7.266s)
[703.997804] [143/156] (365s left) kms_dp_link_training (non-uhbr-sst)
[704.071965] Starting subtest: non-uhbr-sst
[704.080868] Subtest non-uhbr-sst: SKIP (0.000s)
[704.148011] [144/156] (365s left) gem_ctx_isolation (preservation)
[704.202639] Starting subtest: preservation
[704.205230] Starting dynamic subtest: rcs0
[704.334460] Dynamic subtest rcs0: SUCCESS (0.131s)
[704.345533] Starting dynamic subtest: bcs0
[704.493242] Dynamic subtest bcs0: SUCCESS (0.158s)
[704.505235] Starting dynamic subtest: vcs0
[704.630384] Dynamic subtest vcs0: SUCCESS (0.136s)
[704.644525] Starting dynamic subtest: vcs1
[706.361102] Dynamic subtest vcs1: SUCCESS (1.729s)
[706.374279] Starting dynamic subtest: vecs0
[708.341415] Dynamic subtest vecs0: SUCCESS (1.980s)
[708.353538] Starting dynamic subtest: ccs0
[710.340819] Dynamic subtest ccs0: SUCCESS (1.997s)
[710.343275] Subtest preservation: SUCCESS (6.137s)
[710.574161] [145/156] (358s left) syncobj_basic (bad-destroy-pad)
[710.634221] Starting subtest: bad-destroy-pad
[710.636073] Subtest bad-destroy-pad: SUCCESS (0.000s)
[710.732575] [146/156] (358s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[710.817606] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[710.821807] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[710.911383] [147/156] (358s left) syncobj_timeline (etime-single-wait-all-submitted)
[710.972640] Starting subtest: etime-single-wait-all-submitted
[711.081713] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[711.160303] [148/156] (358s left) i915_hangman (hangcheck-unterminated)
[711.216327] Starting subtest: hangcheck-unterminated
[723.165381] Subtest hangcheck-unterminated: SUCCESS (11.948s)
[723.328723] [149/156] (346s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[723.418139] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[723.420390] Starting dynamic subtest: pipe-A-eDP-1
[723.439979] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[723.451814] Starting dynamic subtest: pipe-B-eDP-1
[723.470232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[723.480911] Starting dynamic subtest: pipe-C-eDP-1
[723.500240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[723.510583] Starting dynamic subtest: pipe-D-eDP-1
[723.530255] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[723.532475] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[725.753214] [150/156] (343s left) gem_ctx_param (invalid-ctx-set)
[725.801943] Starting subtest: invalid-ctx-set
[725.804289] Subtest invalid-ctx-set: SUCCESS (0.001s)
[725.906101] [151/156] (343s left) api_intel_allocator (default-alignment)
[725.952971] Starting subtest: default-alignment
[725.955188] Subtest default-alignment: SUCCESS (0.003s)
[726.045491] [152/156] (343s left) prime_vgem (wait)
[726.116381] Starting subtest: wait
[726.118347] Starting dynamic subtest: rcs0
[726.186488] Dynamic subtest rcs0: SUCCESS (0.072s)
[726.196818] Starting dynamic subtest: bcs0
[726.250948] Dynamic subtest bcs0: SUCCESS (0.064s)
[726.262066] Starting dynamic subtest: vcs0
[726.293836] Dynamic subtest vcs0: SUCCESS (0.042s)
[726.304549] Starting dynamic subtest: vcs1
[726.339642] Dynamic subtest vcs1: SUCCESS (0.045s)
[726.350617] Starting dynamic subtest: vecs0
[726.383154] Dynamic subtest vecs0: SUCCESS (0.043s)
[726.393289] Starting dynamic subtest: ccs0
[726.429215] Dynamic subtest ccs0: SUCCESS (0.045s)
[726.431380] Subtest wait: SUCCESS (0.316s)
[726.548428] [153/156] (343s left) kms_flip (flip-vs-blocking-wf-vblank)
[726.623632] Starting subtest: flip-vs-blocking-wf-vblank
[726.625909] Starting dynamic subtest: A-eDP1
[735.588481] Dynamic subtest A-eDP1: SUCCESS (8.967s)
[735.599838] Starting dynamic subtest: B-eDP1
[744.513402] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[744.528216] Starting dynamic subtest: C-eDP1
[753.425316] Dynamic subtest C-eDP1: SUCCESS (8.908s)
[753.436074] Starting dynamic subtest: D-eDP1
[762.362833] Dynamic subtest D-eDP1: SUCCESS (8.936s)
[762.368384] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.744s)
[763.583830] [154/156] (306s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[763.663449] Starting subtest: fbcpsr-shrfb-scaledprimary
[769.471686] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.815s)
[769.605160] [155/156] (300s left) syncobj_wait (invalid-signal-one-illegal-handle)
[769.664815] Starting subtest: invalid-signal-one-illegal-handle
[769.667289] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[769.751370] [156/156] (299s left) vgem_basic (setversion)
[769.788902] Starting subtest: setversion
[769.793357] Subtest setversion: SUCCESS (0.000s)
[769.844604] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_dsc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_exec_gttfill
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: drm_read
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rps
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_lease
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_sequence
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: perf_pmu
results: parsing output: 37/ for test: gem_render_tiled_blits
results: parsing output: 38/ for test: gem_request_retire
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ppgtt
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: gem_ctx_engines
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: vgem_basic
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_invalid_mode
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: fbdev
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_async_flips
results: parsing output: 64/ for test: gem_exec_await
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: sysfs_preempt_timeout
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gen3_render_tiledy_blits
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_selftest
results: parsing output: 78/ for test: kms_color_pipeline
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: core_setmaster
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_params
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: kms_atomic
results: parsing output: 88/ for test: kms_plane
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: api_intel_bb
results: parsing output: 97/ for test: gem_mmap
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: i915_selftest
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_atomic_transition
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_psr2_sf
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: vgem_slow
results: parsing output: 108/ for test: kms_plane_scaling
results: parsing output: 109/ for test: gem_close_race
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: gem_spin_batch
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pipe_crc_basic
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gen9_exec_parse
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: perf_pmu
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_pm_rpm
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_addfb_basic
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_plane
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_vblank
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: gem_exec_parallel
results: parsing output: 135/ for test: syncobj_timeline
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: syncobj_wait
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_dp_link_training
results: parsing output: 143/ for test: gem_ctx_isolation
results: parsing output: 144/ for test: syncobj_basic
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: i915_hangman
results: parsing output: 148/ for test: kms_ccs
results: parsing output: 149/ for test: gem_ctx_param
results: parsing output: 150/ for test: api_intel_allocator
results: parsing output: 151/ for test: prime_vgem
results: parsing output: 152/ for test: kms_flip
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: syncobj_wait
results: parsing output: 155/ for test: vgem_basic
Done.