[58.408623] Initializing watchdogs
[58.408667]   /dev/watchdog0
[58.423208] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.427521] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.429720] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.433490] [001/156] (960s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[59.626950] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[59.942829] [002/156] (959s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[60.039892] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[60.044290] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[60.141918] [003/156] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[60.255153] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[60.259260] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[60.343542] [004/156] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[60.445603] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[60.449872] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[60.561830] [005/156] (958s left) gem_ctx_param (get-priority-new-ctx)
[60.622067] Starting subtest: get-priority-new-ctx
[60.624389] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[60.721142] [006/156] (958s left) gem_userptr_blits (invalid-null-pointer)
[60.787606] Starting subtest: invalid-null-pointer
[60.789738] Subtest invalid-null-pointer: SUCCESS (0.001s)
[60.907207] [007/156] (958s left) kms_psr (fbc-psr-sprite-render)
[60.990151] Starting subtest: fbc-psr-sprite-render
[60.992252] Starting dynamic subtest: eDP-1
[60.996593] Dynamic subtest eDP-1: SKIP (0.000s)
[61.000628] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[61.059895] [008/156] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[61.153439] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[68.259849] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.131s)
[68.404720] [009/156] (950s left) gem_wait (wait)
[68.457695] Starting subtest: wait
[68.459856] Starting dynamic subtest: all-engines
[70.271586] Dynamic subtest all-engines: SUCCESS (1.815s)
[70.281435] Starting dynamic subtest: rcs0
[71.319547] Dynamic subtest rcs0: SUCCESS (1.050s)
[71.331813] Starting dynamic subtest: bcs0
[72.367865] Dynamic subtest bcs0: SUCCESS (1.048s)
[72.377278] Starting dynamic subtest: vcs0
[73.456936] Dynamic subtest vcs0: SUCCESS (1.089s)
[73.465776] Starting dynamic subtest: vcs1
[74.501806] Dynamic subtest vcs1: SUCCESS (1.045s)
[74.509822] Starting dynamic subtest: vecs0
[75.546638] Dynamic subtest vecs0: SUCCESS (1.045s)
[75.557577] Starting dynamic subtest: ccs0
[76.594322] Dynamic subtest ccs0: SUCCESS (1.048s)
[76.596928] Subtest wait: SUCCESS (8.146s)
[76.788814] [010/156] (942s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[76.897318] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[76.901830] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[76.958666] [011/156] (942s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[77.068594] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[81.227193] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.167s)
[82.382167] [012/156] (936s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[82.445924] Starting subtest: y-tiled-to-vebox-x-tiled
[82.450252] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[82.638695] [013/156] (936s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[82.743107] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[82.747760] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[82.828692] [014/156] (936s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[82.929483] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[82.933550] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[83.005370] [015/156] (936s left) kms_cursor_legacy (single-bo)
[83.134474] Starting subtest: single-bo
[83.136874] Starting dynamic subtest: pipe-A
[88.517441] Dynamic subtest pipe-A: SUCCESS (5.379s)
[88.528057] Starting dynamic subtest: pipe-B
[93.898134] Dynamic subtest pipe-B: SUCCESS (5.380s)
[93.905802] Starting dynamic subtest: pipe-C
[99.282264] Dynamic subtest pipe-C: SUCCESS (5.381s)
[99.290070] Starting dynamic subtest: pipe-D
[104.664664] Dynamic subtest pipe-D: SUCCESS (5.381s)
[104.674997] Starting dynamic subtest: all-pipes
[110.052830] Dynamic subtest all-pipes: SUCCESS (5.387s)
[110.055406] Subtest single-bo: SUCCESS (26.916s)
[110.195310] [016/156] (909s left) gem_ctx_isolation (dirty-create)
[110.257833] Starting subtest: dirty-create
[110.260240] Starting dynamic subtest: rcs0
[110.431378] Dynamic subtest rcs0: SUCCESS (0.174s)
[110.441980] Starting dynamic subtest: bcs0
[110.624564] Dynamic subtest bcs0: SUCCESS (0.192s)
[110.635152] Starting dynamic subtest: vcs0
[110.850825] Dynamic subtest vcs0: SUCCESS (0.226s)
[110.859841] Starting dynamic subtest: vcs1
[112.488059] Dynamic subtest vcs1: SUCCESS (1.637s)
[112.497069] Starting dynamic subtest: vecs0
[114.509486] Dynamic subtest vecs0: SUCCESS (2.021s)
[114.519833] Starting dynamic subtest: ccs0
[116.496646] Dynamic subtest ccs0: SUCCESS (1.987s)
[116.499170] Subtest dirty-create: SUCCESS (6.239s)
[116.718981] [017/156] (902s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-move)
[116.823185] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-move
[116.827817] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[116.913329] [018/156] (902s left) kms_getfb (getfb2-accept-nv12)
[116.999795] Starting subtest: getfb2-accept-nv12
[117.002065] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[117.125814] [019/156] (902s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[117.224365] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[117.228701] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[117.331023] [020/156] (902s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[117.434760] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc
[117.439047] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[117.530915] [021/156] (902s left) kms_color_pipeline (plane-lut1d)
[117.624634] Starting subtest: plane-lut1d
[117.782956] Starting dynamic subtest: pipe-A-plane-0
[117.948170] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[117.957194] Starting dynamic subtest: pipe-A-plane-1
[118.081339] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[118.090138] Starting dynamic subtest: pipe-A-plane-2
[118.226095] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[119.453126] Starting dynamic subtest: pipe-B-plane-0
[119.625295] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[119.633327] Starting dynamic subtest: pipe-B-plane-1
[119.757345] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[119.766406] Starting dynamic subtest: pipe-B-plane-2
[119.890440] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[121.111810] Starting dynamic subtest: pipe-C-plane-0
[121.260262] Dynamic subtest pipe-C-plane-0: SUCCESS (0.156s)
[121.269830] Starting dynamic subtest: pipe-C-plane-1
[121.426628] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[121.435507] Starting dynamic subtest: pipe-C-plane-2
[121.559882] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[122.744820] Starting dynamic subtest: pipe-D-plane-0
[122.877407] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[122.885777] Starting dynamic subtest: pipe-D-plane-1
[123.032124] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[123.041655] Starting dynamic subtest: pipe-D-plane-2
[123.176643] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[123.461816] Subtest plane-lut1d: SUCCESS (5.837s)
[124.303157] [022/156] (895s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[124.370453] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[124.438478] [023/156] (895s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[124.540676] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite
[124.544786] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[124.617241] [024/156] (895s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[124.711596] Starting subtest: psr2-plane-move-sf-dmg-area
[124.713867] Starting dynamic subtest: pipe-A-eDP-1
[129.242982] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.535s)
[129.252044] Starting dynamic subtest: pipe-B-eDP-1
[134.552222] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.310s)
[134.554652] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.847s)
[135.426317] [025/156] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[135.528928] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[142.976880] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.453s)
[143.132329] [026/156] (876s left) kms_pm_rpm (dpms-lpsp)
[145.390320] Starting subtest: dpms-lpsp
[145.702982] Subtest dpms-lpsp: SUCCESS (0.310s)
[145.785029] [027/156] (874s left) fbdev (eof)
[145.828108] Starting subtest: eof
[145.830245] Subtest eof: SUCCESS (0.000s)
[145.897809] [028/156] (874s left) gem_bad_reloc (negative-reloc-bltcopy)
[145.963710] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[146.028234] [029/156] (873s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[146.126665] Starting subtest: pipe-fbc-rte
[146.133152] Starting dynamic subtest: pipe-B-eDP-1
[151.630238] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.509s)
[151.637675] Subtest pipe-fbc-rte: SUCCESS (5.511s)
[153.886616] [030/156] (866s left) perf_pmu (busy-idle)
[153.925236] Starting subtest: busy-idle
[153.927319] Starting dynamic subtest: rcs0
[154.616316] Dynamic subtest rcs0: SUCCESS (0.693s)
[154.627463] Starting dynamic subtest: bcs0
[155.290400] Dynamic subtest bcs0: SUCCESS (0.672s)
[155.301822] Starting dynamic subtest: vcs0
[157.311960] Dynamic subtest vcs0: SUCCESS (2.017s)
[157.325046] Starting dynamic subtest: vcs1
[159.296885] Dynamic subtest vcs1: SUCCESS (1.982s)
[159.308547] Starting dynamic subtest: vecs0
[161.279522] Dynamic subtest vecs0: SUCCESS (1.980s)
[161.290452] Starting dynamic subtest: ccs0
[161.944320] Dynamic subtest ccs0: SUCCESS (0.664s)
[161.947431] Subtest busy-idle: SUCCESS (8.021s)
[162.058887] [031/156] (858s left) gem_exec_reloc (basic-cpu-noreloc)
[162.118757] Subtest basic-cpu-noreloc: SKIP (0.000s)
[162.190052] [032/156] (857s left) kms_atomic (crtc-invalid-params)
[162.281897] Starting subtest: crtc-invalid-params
[162.284299] Starting dynamic subtest: pipe-A-eDP-1
[162.641041] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[162.643284] Subtest crtc-invalid-params: SUCCESS (0.359s)
[163.509759] [033/156] (856s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[163.606345] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[163.610954] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[163.710782] [034/156] (856s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-move)
[163.801787] Starting subtest: psrhdr-2p-primscrn-spr-indfb-move
[163.805905] Subtest psrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[163.895078] [035/156] (856s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt)
[163.999750] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt
[164.004150] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[164.106722] [036/156] (856s left) gem_exec_schedule (pi-common)
[164.284588] Starting subtest: pi-common
[164.286984] Starting dynamic subtest: rcs0
[164.356773] Dynamic subtest rcs0: SUCCESS (0.075s)
[164.371465] Starting dynamic subtest: bcs0
[164.383472] Dynamic subtest bcs0: SUCCESS (0.026s)
[164.397517] Starting dynamic subtest: vcs0
[164.410382] Dynamic subtest vcs0: SUCCESS (0.026s)
[164.423098] Starting dynamic subtest: vcs1
[164.437204] Dynamic subtest vcs1: SUCCESS (0.026s)
[164.449988] Starting dynamic subtest: vecs0
[164.462947] Dynamic subtest vecs0: SUCCESS (0.025s)
[164.474609] Starting dynamic subtest: ccs0
[164.490181] Dynamic subtest ccs0: SUCCESS (0.027s)
[164.492454] Subtest pi-common: SUCCESS (0.209s)
[164.707194] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[164.712489] [037/156] (855s left) sysfs_timeslice_duration (timeout)
[164.762677] Starting subtest: timeout
[164.764978] Starting dynamic subtest: vecs0
[174.269755] Dynamic subtest vecs0: SUCCESS (9.502s)
[174.279363] Starting dynamic subtest: ccs0
[175.498954] Dynamic subtest ccs0: SUCCESS (1.229s)
[175.509963] Starting dynamic subtest: vcs0
[185.280267] Dynamic subtest vcs0: SUCCESS (9.778s)
[185.289273] Starting dynamic subtest: bcs0
[185.878085] Dynamic subtest bcs0: SUCCESS (0.598s)
[185.888938] Starting dynamic subtest: rcs0
[187.065596] Dynamic subtest rcs0: SUCCESS (1.184s)
[187.077474] Starting dynamic subtest: vcs1
[196.288995] Dynamic subtest vcs1: SUCCESS (9.222s)
[196.292118] Subtest timeout: SUCCESS (31.522s)
[196.367222] [038/156] (823s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[196.479864] Starting subtest: fbchdr-2p-rte
[196.484168] Subtest fbchdr-2p-rte: SKIP (0.000s)
[196.571377] [039/156] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[196.667984] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[196.672581] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.753916] [040/156] (823s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[196.866358] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[204.378036] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.516s)
[204.516821] [041/156] (815s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[204.620156] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[204.624591] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[204.692056] [042/156] (815s left) gem_softpin (evict-prime)
[204.753418] Starting subtest: evict-prime
[204.755940] Starting dynamic subtest: rcs0
[205.909626] Dynamic subtest rcs0: SUCCESS (1.155s)
[205.919248] Starting dynamic subtest: bcs0
[207.025894] Dynamic subtest bcs0: SUCCESS (1.115s)
[207.035669] Starting dynamic subtest: vcs0
[208.325736] Dynamic subtest vcs0: SUCCESS (1.297s)
[208.337757] Starting dynamic subtest: vcs1
[210.239561] Dynamic subtest vcs1: SUCCESS (1.912s)
[210.251049] Starting dynamic subtest: vecs0
[212.289501] Dynamic subtest vecs0: SUCCESS (2.048s)
[212.301306] Starting dynamic subtest: ccs0
[213.407710] Dynamic subtest ccs0: SUCCESS (1.118s)
[213.416426] Starting dynamic subtest: all
[215.299245] Dynamic subtest all: SUCCESS (1.889s)
[215.302041] Subtest evict-prime: SUCCESS (10.546s)
[215.376345] [043/156] (805s left) kms_vblank (ts-continuation-modeset)
[215.475888] Starting subtest: ts-continuation-modeset
[215.478075] Starting dynamic subtest: pipe-A-eDP-1
[217.027207] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.550s)
[217.042467] Starting dynamic subtest: pipe-D-eDP-1
[219.191095] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.160s)
[219.193498] Subtest ts-continuation-modeset: SUCCESS (3.716s)
[220.003397] [044/156] (800s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[220.121594] Starting subtest: cursorB-vs-flipB-atomic
[220.126238] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[220.284741] [045/156] (800s left) kms_psr (fbc-psr2-basic)
[220.386351] Starting subtest: fbc-psr2-basic
[220.388281] Starting dynamic subtest: eDP-1
[220.392387] Dynamic subtest eDP-1: SKIP (0.000s)
[220.396535] Subtest fbc-psr2-basic: SKIP (0.001s)
[220.463432] [046/156] (800s left) kms_psr (pr-sprite-mmap-gtt)
[220.552390] Starting subtest: pr-sprite-mmap-gtt
[220.556425] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[220.640885] [047/156] (800s left) perf (polling-parameterized)
[220.764928] Starting subtest: polling-parameterized
[240.788068] Subtest polling-parameterized: SUCCESS (20.020s)
[240.836299] [048/156] (779s left) gem_mmap_gtt (fault-concurrent-y)
[240.898980] Subtest fault-concurrent-Y: SKIP (0.000s)
[240.955357] [049/156] (779s left) kms_async_flips (crc-atomic)
[241.045371] Starting subtest: crc-atomic
[241.417085] Starting dynamic subtest: pipe-A-eDP-1
[244.329989] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.915s)
[244.718448] Starting dynamic subtest: pipe-B-eDP-1
[247.660358] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.951s)
[248.050759] Starting dynamic subtest: pipe-C-eDP-1
[250.964283] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.927s)
[251.344857] Starting dynamic subtest: pipe-D-eDP-1
[254.216623] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.882s)
[254.219060] Subtest crc-atomic: SUCCESS (13.172s)
[255.374501] [050/156] (765s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[255.430822] Starting subtest: multi-wait-all-for-submit-available-signaled
[255.433159] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[255.545119] [051/156] (765s left) syncobj_timeline (host-signal-points)
[255.600695] Starting subtest: host-signal-points
[255.605849] Subtest host-signal-points: SUCCESS (0.005s)
[255.721669] [052/156] (765s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[255.821697] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[255.826106] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[255.902970] [053/156] (765s left) kms_flip (2x-flip-vs-dpms)
[256.007020] Starting subtest: 2x-flip-vs-dpms
[256.015839] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[256.091179] [054/156] (764s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[256.193963] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[256.198473] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[256.315989] [055/156] (764s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[256.409129] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[256.412565] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[256.507412] [056/156] (764s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[256.602961] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[256.604938] Starting dynamic subtest: pipe-A-eDP-1
[256.623077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.631751] Starting dynamic subtest: pipe-B-eDP-1
[256.649290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.657376] Starting dynamic subtest: pipe-C-eDP-1
[256.674492] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.682790] Starting dynamic subtest: pipe-D-eDP-1
[256.700938] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.704480] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[258.934682] [057/156] (762s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[259.024384] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[262.926735] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.908s)
[264.133864] [058/156] (757s left) gem_exec_schedule (implicit-read-write)
[264.212509] Starting subtest: implicit-read-write
[264.214924] Starting dynamic subtest: rcs0
[264.316607] Dynamic subtest rcs0: SUCCESS (0.112s)
[264.325737] Starting dynamic subtest: vcs0
[264.403233] Dynamic subtest vcs0: SUCCESS (0.085s)
[264.416290] Starting dynamic subtest: vcs1
[264.479505] Dynamic subtest vcs1: SUCCESS (0.076s)
[264.491695] Starting dynamic subtest: vecs0
[264.552539] Dynamic subtest vecs0: SUCCESS (0.073s)
[264.562809] Starting dynamic subtest: ccs0
[264.635930] Dynamic subtest ccs0: SUCCESS (0.083s)
[264.638549] Subtest implicit-read-write: SUCCESS (0.433s)
[266.391203] [059/156] (754s left) kms_cursor_crc (cursor-rapid-movement-64x21)
[266.583199] Starting subtest: cursor-rapid-movement-64x21
[266.632716] Subtest cursor-rapid-movement-64x21: SKIP (0.046s)
[266.857921] [060/156] (754s left) kms_cursor_crc (cursor-sliding-64x21)
[267.041852] Starting subtest: cursor-sliding-64x21
[267.092945] Subtest cursor-sliding-64x21: SKIP (0.046s)
[267.320125] [061/156] (753s left) gem_exec_parallel (fds)
[267.372646] Starting subtest: fds
[267.374589] Starting dynamic subtest: rcs0
[269.703898] Dynamic subtest rcs0: SUCCESS (2.330s)
[269.716536] Starting dynamic subtest: bcs0
[272.890389] Dynamic subtest bcs0: SUCCESS (3.183s)
[272.902776] Starting dynamic subtest: vcs0
[276.561357] Dynamic subtest vcs0: SUCCESS (3.669s)
[276.572670] Starting dynamic subtest: vcs1
[280.515499] Dynamic subtest vcs1: SUCCESS (3.952s)
[280.525896] Starting dynamic subtest: vecs0
[284.559627] Dynamic subtest vecs0: SUCCESS (4.041s)
[284.569063] Starting dynamic subtest: ccs0
[288.241310] Dynamic subtest ccs0: SUCCESS (3.679s)
[288.244290] Subtest fds: SUCCESS (20.867s)
[288.438829] [062/156] (732s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[288.545256] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[288.574587] Starting dynamic subtest: pipe-A-plane-0
[288.997870] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[289.007738] Starting dynamic subtest: pipe-A-plane-3
[289.330334] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[290.414266] Starting dynamic subtest: pipe-B-plane-0
[290.817694] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[290.827868] Starting dynamic subtest: pipe-B-plane-3
[291.151466] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[291.475812] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.929s)
[292.292245] [063/156] (729s left) gem_ctx_persistence (heartbeat-stop)
[292.349757] Starting subtest: heartbeat-stop
[292.354439] Subtest heartbeat-stop: SKIP (0.000s)
[292.450735] [064/156] (728s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render)
[292.540415] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render
[292.544406] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[292.643424] [065/156] (728s left) gem_exec_reloc (basic-gtt-read-noreloc)
[292.708117] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[292.781722] [066/156] (728s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[292.877363] Starting subtest: 2x-plain-flip-ts-check-interruptible
[292.887820] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[292.963307] [067/156] (728s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[293.057810] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[294.059704] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s)
[294.192724] [068/156] (727s left) kms_psr (psr-primary-render)
[294.275039] Starting subtest: psr-primary-render
[294.277268] Starting dynamic subtest: eDP-1
[295.998976] Dynamic subtest eDP-1: SUCCESS (1.725s)
[296.001213] Subtest psr-primary-render: SUCCESS (1.726s)
[296.853879] [069/156] (724s left) gem_pread (display)
[296.914897] Subtest display: SKIP (0.000s)
[296.975127] [070/156] (724s left) gem_exec_schedule (thriceslice)
[297.040961] Starting subtest: thriceslice
[297.043358] Starting dynamic subtest: rcs0
[297.084242] Dynamic subtest rcs0: SUCCESS (0.053s)
[297.095478] Starting dynamic subtest: bcs0
[297.138053] Dynamic subtest bcs0: SUCCESS (0.052s)
[297.149259] Starting dynamic subtest: vcs0
[297.191398] Dynamic subtest vcs0: SUCCESS (0.051s)
[297.202814] Starting dynamic subtest: vcs1
[297.222532] Dynamic subtest vcs1: SUCCESS (0.029s)
[297.234252] Starting dynamic subtest: vecs0
[297.253175] Dynamic subtest vecs0: SUCCESS (0.029s)
[297.262267] Starting dynamic subtest: ccs0
[297.309621] Dynamic subtest ccs0: SUCCESS (0.054s)
[297.312189] Subtest thriceslice: SUCCESS (0.280s)
[298.342981] [071/156] (723s left) gem_render_copy_redux (normal)
[298.395914] Starting subtest: normal
[298.664101] Subtest normal: SUCCESS (0.269s)
[298.799452] [072/156] (722s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[298.853916] Starting subtest: wait-all-for-submit-delayed-submit
[298.955658] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[299.036046] [073/156] (722s left) gem_create (create-ext-cpu-access-sanity-check)
[299.201234] Starting subtest: create-ext-cpu-access-sanity-check
[299.205897] Subtest create-ext-cpu-access-sanity-check: SKIP (0.002s)
[299.271377] [074/156] (722s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[299.360168] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[299.362422] Starting dynamic subtest: pipe-A-eDP-1
[299.384700] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[299.395618] Starting dynamic subtest: pipe-B-eDP-1
[299.416895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[299.425219] Starting dynamic subtest: pipe-C-eDP-1
[299.446602] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[299.455051] Starting dynamic subtest: pipe-D-eDP-1
[299.476787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[299.481738] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[301.622268] [075/156] (720s left) syncobj_wait (invalid-reset-illegal-handle)
[301.674991] Starting subtest: invalid-reset-illegal-handle
[301.677046] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[301.773727] [076/156] (720s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[301.857177] Starting subtest: coverage-vs-premult-vs-constant
[302.129710] Starting dynamic subtest: pipe-A-eDP-1
[302.710848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.581s)
[302.720622] Starting dynamic subtest: pipe-D-eDP-1
[304.027432] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[304.029650] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.170s)
[304.878262] [077/156] (717s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[304.982505] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[304.984900] Starting dynamic subtest: pipe-A
[305.046696] Dynamic subtest pipe-A: SUCCESS (0.066s)
[305.056896] Starting dynamic subtest: pipe-B
[306.209272] Dynamic subtest pipe-B: SUCCESS (1.161s)
[306.221020] Starting dynamic subtest: pipe-C
[307.310318] Dynamic subtest pipe-C: SUCCESS (1.099s)
[307.320550] Starting dynamic subtest: pipe-D
[308.443884] Dynamic subtest pipe-D: SUCCESS (1.133s)
[308.446401] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.464s)
[309.598440] [078/156] (712s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt)
[309.697417] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt
[309.701339] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[309.776929] [079/156] (712s left) kms_big_fb (y-tiled-addfb)
[309.883324] Starting subtest: y-tiled-addfb
[309.887396] Subtest y-tiled-addfb: SKIP (0.000s)
[309.972663] [080/156] (712s left) gem_mmap_gtt (basic-read-write)
[310.030191] Subtest basic-read-write: SKIP (0.000s)
[310.093301] [081/156] (712s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[310.185769] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[310.190078] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[310.291309] [082/156] (711s left) api_intel_bb (blit-noreloc-keep-cache)
[310.346472] Starting subtest: blit-noreloc-keep-cache
[310.353659] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[310.488011] [083/156] (711s left) kms_frontbuffer_tracking (psr-slowdraw)
[310.590162] Starting subtest: psr-slowdraw
[335.808366] Subtest psr-slowdraw: SUCCESS (25.222s)
[335.955511] [084/156] (686s left) vgem_slow (nohang)
[336.006404] Starting subtest: nohang
[346.077059] Subtest nohang: SUCCESS (10.070s)
[346.139611] [085/156] (676s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[346.236345] Starting subtest: psr-1p-pri-indfb-multidraw
[369.141327] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.908s)
[369.266417] [086/156] (653s left) sw_sync (sync_expired_merge)
[369.308057] Starting subtest: sync_expired_merge
[370.382898] Subtest sync_expired_merge: SUCCESS (1.074s)
[370.444496] [087/156] (651s left) kms_invalid_mode (zero-hdisplay)
[370.534834] Starting subtest: zero-hdisplay
[370.537597] Starting dynamic subtest: pipe-A-eDP-1
[370.822818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[370.834115] Starting dynamic subtest: pipe-B-eDP-1
[370.835947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[370.845068] Starting dynamic subtest: pipe-C-eDP-1
[370.847172] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[370.856101] Starting dynamic subtest: pipe-D-eDP-1
[370.858200] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[370.860327] Subtest zero-hdisplay: SUCCESS (0.295s)
[371.693115] [088/156] (650s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[371.784773] Starting subtest: hdr-rgb565-draw-mmap-wc
[371.789073] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[371.891825] [089/156] (650s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[372.000445] Starting subtest: yf-tiled-8bpp-rotate-0
[372.004927] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[372.114412] [090/156] (650s left) i915_query (query-regions-garbage-items)
[372.169956] Starting subtest: query-regions-garbage-items
[372.172384] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[372.291037] [091/156] (650s left) kms_hdmi_inject (inject-audio)
[372.629414] Starting subtest: inject-audio
[372.922739] Subtest inject-audio: SUCCESS (0.296s)
[373.548155] [092/156] (649s left) kms_feature_discovery (psr1)
[373.651361] Starting subtest: psr1
[373.653682] Subtest psr1: SUCCESS (0.000s)
[373.723022] [093/156] (648s left) core_getclient (basic)
[373.787955] Starting subtest: basic
[373.790382] Subtest basic: SUCCESS (0.000s)
[373.902341] [094/156] (648s left) gem_mmap_offset (ptrace)
[373.955064] Starting subtest: ptrace
[373.957302] Starting dynamic subtest: smem0-wb
[373.971665] Dynamic subtest smem0-wb: SUCCESS (0.016s)
[373.982074] Starting dynamic subtest: smem0-wc
[373.992865] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[374.001756] Starting dynamic subtest: smem0-uc
[374.013782] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[374.016117] Subtest ptrace: SUCCESS (0.062s)
[374.151868] [095/156] (648s left) gem_exec_balancer (parallel-balancer)
[374.412190] Starting subtest: parallel-balancer
[375.353812] Subtest parallel-balancer: SUCCESS (0.942s)
[375.452716] [096/156] (647s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[375.550063] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[375.552488] Starting dynamic subtest: pipe-A-eDP-1
[375.574828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[375.584110] Starting dynamic subtest: pipe-B-eDP-1
[375.608498] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[375.617225] Starting dynamic subtest: pipe-C-eDP-1
[375.640698] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[375.649373] Starting dynamic subtest: pipe-D-eDP-1
[375.670665] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[375.675085] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[377.810077] [097/156] (644s left) i915_pm_rc6_residency (media-rc6-accuracy)
[377.857679] Starting subtest: media-rc6-accuracy
[377.861812] Subtest media-rc6-accuracy: SKIP (0.000s)
[377.948870] [098/156] (644s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[378.041945] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[378.832660] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.792s)
[378.992707] [099/156] (643s left) kms_flip (flip-vs-dpms-on-nop)
[379.085064] Starting subtest: flip-vs-dpms-on-nop
[379.087445] Starting dynamic subtest: A-eDP1
[380.975910] Dynamic subtest A-eDP1: SUCCESS (1.890s)
[380.986328] Starting dynamic subtest: B-eDP1
[382.885205] Dynamic subtest B-eDP1: SUCCESS (1.908s)
[382.900161] Starting dynamic subtest: C-eDP1
[384.758840] Dynamic subtest C-eDP1: SUCCESS (1.872s)
[384.768191] Starting dynamic subtest: D-eDP1
[386.663396] Dynamic subtest D-eDP1: SUCCESS (1.904s)
[386.668662] Subtest flip-vs-dpms-on-nop: SUCCESS (7.582s)
[387.922811] [100/156] (634s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[388.016260] Starting subtest: plane-scaler-unity-scaling-with-rotation
[388.018558] Starting dynamic subtest: pipe-A
[388.243068] Dynamic subtest pipe-A: SUCCESS (0.229s)
[388.252160] Starting dynamic subtest: pipe-B
[389.559530] Dynamic subtest pipe-B: SUCCESS (1.314s)
[389.568863] Starting dynamic subtest: pipe-C
[390.858477] Dynamic subtest pipe-C: SUCCESS (1.298s)
[390.868613] Starting dynamic subtest: pipe-D
[392.156292] Dynamic subtest pipe-D: SUCCESS (1.295s)
[392.158725] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.143s)
[393.306877] [101/156] (629s left) kms_prop_blob (blob-prop-core)
[393.360740] Starting subtest: blob-prop-core
[393.362795] Subtest blob-prop-core: SUCCESS (0.000s)
[393.486870] [102/156] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[393.588420] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[393.592568] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[393.672967] [103/156] (629s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[393.772805] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[393.777039] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[393.877629] [104/156] (629s left) gem_eio (unwedge-stress)
[394.100810] Starting subtest: unwedge-stress
[394.103239] Starting dynamic subtest: render
[398.915361] Dynamic subtest render: SUCCESS (4.813s)
[398.925520] Starting dynamic subtest: bsd1
[418.801331] Dynamic subtest bsd1: SUCCESS (19.882s)
[418.817790] Starting dynamic subtest: bsd2
[436.774831] Dynamic subtest bsd2: SUCCESS (17.973s)
[436.790028] Starting dynamic subtest: blt
[436.794280] Dynamic subtest blt: SKIP (0.000s)
[436.803465] Starting dynamic subtest: vebox
[454.741397] Dynamic subtest vebox: SUCCESS (17.965s)
[454.743401] Subtest unwedge-stress: SUCCESS (60.639s)
[456.377049] [105/156] (566s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[456.460208] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[456.462493] Starting dynamic subtest: pipe-A-default-mode
[459.275527] Dynamic subtest pipe-A-default-mode: SUCCESS (2.814s)
[459.277852] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.815s)
[460.108168] [106/156] (563s left) i915_drm_fdinfo (most-busy-idle-check-all)
[460.147183] Starting subtest: most-busy-idle-check-all
[460.149730] Starting dynamic subtest: rcs0
[460.154744] Dynamic subtest rcs0: SKIP (0.003s)
[460.164632] Starting dynamic subtest: bcs0
[460.169026] Dynamic subtest bcs0: SKIP (0.000s)
[460.178384] Starting dynamic subtest: vcs0
[460.182530] Dynamic subtest vcs0: SKIP (0.000s)
[460.191177] Starting dynamic subtest: vcs1
[460.195234] Dynamic subtest vcs1: SKIP (0.000s)
[460.204288] Starting dynamic subtest: vecs0
[460.208372] Dynamic subtest vecs0: SKIP (0.000s)
[460.217473] Starting dynamic subtest: ccs0
[460.221636] Dynamic subtest ccs0: SKIP (0.000s)
[460.225804] Subtest most-busy-idle-check-all: SKIP (0.009s)
[460.263283] [107/156] (562s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[460.371332] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[460.375613] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[460.473977] [108/156] (562s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[460.571761] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[460.576034] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[460.670969] [109/156] (562s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[460.768090] Starting subtest: 4-tiled-addfb-size-offset-overflow
[460.770403] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[460.862489] [110/156] (562s left) gem_mmap_offset (bad-extensions)
[460.911602] Starting subtest: bad-extensions
[460.914070] Subtest bad-extensions: SUCCESS (0.000s)
[461.004430] [111/156] (562s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[461.105148] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[461.108807] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[461.201629] [112/156] (562s left) kms_flip (2x-flip-vs-panning-vs-hang)
[461.287694] Starting subtest: 2x-flip-vs-panning-vs-hang
[461.291441] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[461.390025] [113/156] (562s left) gem_ctx_shared (exec-single-timeline)
[461.448808] Starting subtest: exec-single-timeline
[461.450657] Starting dynamic subtest: rcs0
[462.492746] Dynamic subtest rcs0: SUCCESS (1.041s)
[462.509282] Starting dynamic subtest: bcs0
[463.580450] Dynamic subtest bcs0: SUCCESS (1.084s)
[463.592120] Starting dynamic subtest: vcs0
[464.669248] Dynamic subtest vcs0: SUCCESS (1.085s)
[464.682999] Starting dynamic subtest: vcs1
[465.755754] Dynamic subtest vcs1: SUCCESS (1.083s)
[465.769749] Starting dynamic subtest: vecs0
[466.845892] Dynamic subtest vecs0: SUCCESS (1.088s)
[466.861177] Starting dynamic subtest: ccs0
[467.933130] Dynamic subtest ccs0: SUCCESS (1.084s)
[467.935981] Subtest exec-single-timeline: SUCCESS (6.484s)
[468.126608] [114/156] (555s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[468.239826] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[468.243986] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[468.331708] [115/156] (555s left) gem_pxp (hw-rejects-pxp-context)
[468.464796] Starting subtest: hw-rejects-pxp-context
[468.469903] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[468.584773] [116/156] (554s left) i915_pm_freq_mult (media-freq)
[468.638315] Starting subtest: media-freq
[468.640794] Starting dynamic subtest: gt0
[468.645242] Dynamic subtest gt0: SKIP (0.000s)
[468.655687] Starting dynamic subtest: gt1
[468.659677] Dynamic subtest gt1: SKIP (0.000s)
[468.663755] Subtest media-freq: SKIP (0.002s)
[468.755641] [117/156] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[468.868939] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[468.873300] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[468.959778] [118/156] (554s left) gem_exec_whisper (basic-contexts-forked)
[469.036486] Starting subtest: basic-contexts-forked
[493.547815] Subtest basic-contexts-forked: SUCCESS (24.506s)
[493.732845] [119/156] (529s left) kms_cursor_crc (cursor-onscreen-max-size)
[494.067217] Starting subtest: cursor-onscreen-max-size
[494.073408] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[494.191545] [120/156] (529s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt)
[494.291299] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt
[494.295441] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[494.375463] [121/156] (529s left) kms_lease (lease-invalid-crtc)
[494.474219] Starting subtest: lease-invalid-crtc
[494.477370] Starting dynamic subtest: pipe-A-eDP-1
[494.479927] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[494.489152] Starting dynamic subtest: pipe-B-eDP-1
[494.491506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[494.501110] Starting dynamic subtest: pipe-C-eDP-1
[494.503453] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[494.512453] Starting dynamic subtest: pipe-D-eDP-1
[494.514433] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[494.516340] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[494.563205] [122/156] (529s left) kms_psr (psr2-sprite-render)
[494.651029] Starting subtest: psr2-sprite-render
[494.653376] Starting dynamic subtest: eDP-1
[496.376291] Dynamic subtest eDP-1: SUCCESS (1.723s)
[496.378638] Subtest psr2-sprite-render: SUCCESS (1.724s)
[497.209879] [123/156] (526s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[497.264994] Starting subtest: etime-multi-wait-all-for-submit-submitted
[497.371450] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[497.447768] [124/156] (526s left) gem_eio (in-flight-1us)
[497.659965] Starting subtest: in-flight-1us
[506.129610] Subtest in-flight-1us: SUCCESS (8.468s)
[506.311889] [125/156] (517s left) kms_rotation_crc (bad-pixel-format)
[506.400315] Starting subtest: bad-pixel-format
[506.404925] Subtest bad-pixel-format: SKIP (0.001s)
[506.473400] [126/156] (517s left) kms_chamelium_frames (dp-frame-dump)
[506.852795] Subtest dp-frame-dump: SKIP (0.000s)
[507.689769] [127/156] (516s left) vgem_basic (debugfs)
[507.724878] Starting subtest: debugfs
[507.726769] Subtest debugfs: SUCCESS (0.000s)
[507.782957] [128/156] (516s left) gen9_exec_parse (allowed-single)
[507.846394] Subtest allowed-single: SKIP (0.000s)
[507.926532] [129/156] (516s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[508.027891] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[508.032353] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[508.132339] [130/156] (516s left) i915_query (query-topology-known-pci-ids)
[508.178889] Starting subtest: query-topology-known-pci-ids
[508.183347] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[508.264477] [131/156] (515s left) prime_vgem (coherency-blt)
[508.325586] Starting subtest: coherency-blt
[509.534850] Subtest coherency-blt: SUCCESS (1.207s)
[509.653495] [132/156] (514s left) gem_mmap_gtt (big-copy-odd)
[509.705664] Subtest big-copy-odd: SKIP (0.000s)
[509.767484] [133/156] (514s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[509.871854] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[509.876249] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[509.973536] [134/156] (514s left) kms_fbcon_fbt (psr-suspend)
[510.029902] Starting subtest: psr-suspend
[560.167936] Subtest psr-suspend: SUCCESS (20.403s)
[560.240383] [135/156] (464s left) kms_vblank (invalid)
[560.355248] Starting subtest: invalid
[560.357095] Starting dynamic subtest: pipe-A-eDP-1
[560.761215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[560.763513] Subtest invalid: SUCCESS (0.410s)
[561.640357] [136/156] (462s left) vgem_basic (dmabuf-mmap)
[561.679127] Starting subtest: dmabuf-mmap
[561.699306] Subtest dmabuf-mmap: SUCCESS (0.022s)
[561.758291] [137/156] (462s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[561.817009] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[561.925747] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[562.005823] [138/156] (462s left) syncobj_wait (multi-wait-for-submit-signaled)
[562.048452] Starting subtest: multi-wait-for-submit-signaled
[562.050585] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[562.155107] [139/156] (462s left) gem_tiled_blits (basic)
[562.210372] Subtest basic: SKIP (0.000s)
[562.274913] [140/156] (462s left) gem_exec_balancer (parallel-ordering)
[562.541313] Starting subtest: parallel-ordering
[563.502027] Subtest parallel-ordering: SUCCESS (0.970s)
[563.635057] [141/156] (460s left) gem_lmem_swapping (basic)
[563.678014] Subtest basic: SKIP (0.000s)
[563.716621] [142/156] (460s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[563.816233] Starting subtest: random-ccs-data-yf-tiled-ccs
[563.818471] Starting dynamic subtest: pipe-A-eDP-1
[563.842826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[563.854967] Starting dynamic subtest: pipe-B-eDP-1
[563.877450] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[563.887614] Starting dynamic subtest: pipe-C-eDP-1
[563.910629] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[563.920490] Starting dynamic subtest: pipe-D-eDP-1
[563.944617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[563.948574] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[566.020878] [143/156] (458s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw)
[566.122061] Starting subtest: fbcpsrhdr-slowdraw
[566.126531] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s)
[566.218684] [144/156] (458s left) syncobj_timeline (signal-point-0)
[566.271625] Starting subtest: signal-point-0
[566.273920] Subtest signal-point-0: SUCCESS (0.000s)
[566.387031] [145/156] (458s left) gem_mmap_wc (close)
[566.431998] Subtest close: SKIP (0.000s)
[566.504881] [146/156] (458s left) device_reset (cold-reset-bound)
[566.551680] Starting subtest: cold-reset-bound
[566.556165] Subtest cold-reset-bound: SKIP (0.000s)
[566.622496] [147/156] (458s left) kms_content_protection (atomic-dpms-hdcp14)
[566.745314] Starting subtest: atomic-dpms-hdcp14
[566.749987] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[566.883515] [148/156] (457s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-blt)
[566.985467] Starting subtest: fbchdr-rgb565-draw-blt
[566.988873] Subtest fbchdr-rgb565-draw-blt: SKIP (0.000s)
[567.087865] [149/156] (457s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[567.214163] Starting subtest: flip-vs-cursor-varying-size
[576.149428] Subtest flip-vs-cursor-varying-size: SUCCESS (8.950s)
[576.989661] [150/156] (447s left) gem_ctx_param (invalid-ctx-set)
[577.039145] Starting subtest: invalid-ctx-set
[577.041514] Subtest invalid-ctx-set: SUCCESS (0.001s)
[577.142578] [151/156] (447s left) gem_exec_fence (long-history)
[577.559749] Starting subtest: long-history
[584.893551] Subtest long-history: SUCCESS (7.343s)
[585.435498] [152/156] (439s left) gem_mmap_gtt (big-bo)
[585.484824] Subtest big-bo: SKIP (0.000s)
[585.541181] [153/156] (439s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[585.641968] Starting subtest: psr-rgb101010-draw-render
[593.008120] Subtest psr-rgb101010-draw-render: SUCCESS (7.374s)
[593.134072] [154/156] (431s left) gem_partial_pwrite_pread (writes-after-reads)
[593.199015] Subtest writes-after-reads: SKIP (0.000s)
[593.274880] [155/156] (431s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[593.359849] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[593.362034] Starting dynamic subtest: pipe-A-eDP-1
[593.418276] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[593.430479] Starting dynamic subtest: pipe-B-eDP-1
[593.486093] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[593.496644] Starting dynamic subtest: pipe-C-eDP-1
[593.550960] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[593.561875] Starting dynamic subtest: pipe-D-eDP-1
[593.616538] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[593.620873] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s)
[595.578442] [156/156] (429s left) gem_exec_capture (userptr)
[595.635352] Starting subtest: userptr
[596.473769] Subtest userptr: SUCCESS (0.837s)
[596.605803] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_ctx_param
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_wait
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: gem_ctx_isolation
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_getfb
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_color_pipeline
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_pm_rpm
results: parsing output: 26/ for test: fbdev
results: parsing output: 27/ for test: gem_bad_reloc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_atomic
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: sysfs_timeslice_duration
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_schedule
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: gem_exec_parallel
results: parsing output: 61/ for test: kms_plane
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_reloc
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_render_copy_redux
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_plane_alpha_blend
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: api_intel_bb
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: vgem_slow
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: sw_sync
results: parsing output: 86/ for test: kms_invalid_mode
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: i915_query
results: parsing output: 90/ for test: kms_hdmi_inject
results: parsing output: 91/ for test: kms_feature_discovery
results: parsing output: 92/ for test: core_getclient
results: parsing output: 93/ for test: gem_mmap_offset
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: i915_pm_rc6_residency
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_plane_scaling
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: gem_mmap_offset
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_pxp
results: parsing output: 115/ for test: i915_pm_freq_mult
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_lease
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_chamelium_frames
results: parsing output: 126/ for test: vgem_basic
results: parsing output: 127/ for test: gen9_exec_parse
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_fbcon_fbt
results: parsing output: 134/ for test: kms_vblank
results: parsing output: 135/ for test: vgem_basic
results: parsing output: 136/ for test: syncobj_wait
results: parsing output: 137/ for test: syncobj_wait
results: parsing output: 138/ for test: gem_tiled_blits
results: parsing output: 139/ for test: gem_exec_balancer
results: parsing output: 140/ for test: gem_lmem_swapping
results: parsing output: 141/ for test: kms_ccs
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: syncobj_timeline
results: parsing output: 144/ for test: gem_mmap_wc
results: parsing output: 145/ for test: device_reset
results: parsing output: 146/ for test: kms_content_protection
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_ctx_param
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: gem_mmap_gtt
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_partial_pwrite_pread
results: parsing output: 154/ for test: kms_ccs
results: parsing output: 155/ for test: gem_exec_capture
Done.