[57.325511] Initializing watchdogs
[57.325588]   /dev/watchdog0
[57.341370] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.345597] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.347737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.351586] [001/156] (960s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[57.474228] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[57.478201] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[57.570830] [002/156] (960s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[57.650824] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[57.653184] Starting dynamic subtest: pipe-A-eDP-1
[57.673271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[57.682609] Starting dynamic subtest: pipe-B-eDP-1
[57.701680] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[57.709275] Starting dynamic subtest: pipe-C-eDP-1
[57.728573] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[57.735661] Starting dynamic subtest: pipe-D-eDP-1
[57.755122] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[57.757312] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.003s)
[59.904242] [003/156] (958s left) gem_ctx_create (basic)
[59.972681] Starting subtest: basic
[59.974898] Subtest basic: SUCCESS (0.000s)
[60.148113] [004/156] (957s left) kms_addfb_basic (addfb25-bad-modifier)
[60.224731] Starting subtest: addfb25-bad-modifier
[60.226988] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[60.333110] [005/156] (957s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[60.419441] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[60.423715] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[60.529043] [006/156] (957s left) api_intel_bb (destroy-bb)
[60.585917] Starting subtest: destroy-bb
[60.593395] Subtest destroy-bb: SUCCESS (0.009s)
[60.716724] [007/156] (957s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[60.771703] Starting subtest: wait-all-for-submit-delayed-submit
[60.877389] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[60.946958] [008/156] (957s left) gem_lmem_swapping (parallel-random)
[60.991078] Subtest parallel-random: SKIP (0.000s)
[61.031849] [009/156] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[61.118545] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[61.122764] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[61.235472] [010/156] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[61.328663] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[61.333192] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[61.420556] [011/156] (956s left) kms_vrr (flip-suspend)
[61.495758] Starting subtest: flip-suspend
[61.501985] Subtest flip-suspend: SKIP (0.000s)
[61.567088] [012/156] (956s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-msflip-blt)
[61.663576] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-msflip-blt
[61.667462] Subtest fbcpsrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[61.749867] [013/156] (956s left) syncobj_timeline (reset-unsignaled)
[61.812662] Starting subtest: reset-unsignaled
[61.815114] Subtest reset-unsignaled: SUCCESS (0.000s)
[61.913394] [014/156] (956s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[61.986965] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[61.990526] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[62.084761] [015/156] (956s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[62.136833] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[62.201368] [016/156] (956s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[62.285636] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[62.929348] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[63.097181] [017/156] (955s left) kms_chamelium_edid (vga-edid-read)
[63.465164] Subtest vga-edid-read: SKIP (0.000s)
[64.294556] [018/156] (954s left) kms_addfb_basic (tile-pitch-mismatch)
[64.344999] Starting subtest: tile-pitch-mismatch
[64.349851] Subtest tile-pitch-mismatch: SKIP (0.000s)
[64.457558] [019/156] (954s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[64.523626] Starting subtest: multiplane-rotation-cropping-bottom
[81.899955] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.404s)
[81.998810] [020/156] (936s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[82.087499] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[82.091096] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[82.195780] [021/156] (936s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible)
[82.275996] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible
[82.277933] Starting dynamic subtest: A-eDP1
[85.940166] Dynamic subtest A-eDP1: SUCCESS (3.663s)
[85.949083] Starting dynamic subtest: B-eDP1
[89.158203] Dynamic subtest B-eDP1: SUCCESS (3.215s)
[89.168137] Starting dynamic subtest: C-eDP1
[92.373909] Dynamic subtest C-eDP1: SUCCESS (3.215s)
[92.381972] Starting dynamic subtest: D-eDP1
[96.296863] Dynamic subtest D-eDP1: SUCCESS (3.919s)
[96.299450] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (14.019s)
[96.676670] [022/156] (921s left) vgem_slow (nohang)
[96.766456] Starting subtest: nohang
[106.910039] Subtest nohang: SUCCESS (10.142s)
[106.995356] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[106.998714] [023/156] (911s left) kms_force_connector_basic (prune-stale-modes)
[107.054396] Subtest prune-stale-modes: SKIP (0.000s)
[107.119187] [024/156] (911s left) kms_hdr (invalid-metadata-sizes)
[107.204410] Starting subtest: invalid-metadata-sizes
[107.206624] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[107.210708] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[107.219796] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[107.224124] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[107.228465] Subtest invalid-metadata-sizes: SKIP (0.002s)
[107.277053] [025/156] (911s left) syncobj_wait (single-wait-submitted)
[107.327654] Starting subtest: single-wait-submitted
[107.434972] Subtest single-wait-submitted: SUCCESS (0.107s)
[107.512261] [026/156] (911s left) kms_prop_blob (invalid-get-prop)
[107.562694] Starting subtest: invalid-get-prop
[107.565020] Subtest invalid-get-prop: SUCCESS (0.000s)
[107.674798] [027/156] (911s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[107.762234] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[115.105667] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.352s)
[115.262989] [028/156] (903s left) kms_psr (psr2-cursor-render)
[115.342859] Starting subtest: psr2-cursor-render
[115.345133] Starting dynamic subtest: eDP-1
[117.066167] Dynamic subtest eDP-1: SUCCESS (1.724s)
[117.068451] Subtest psr2-cursor-render: SUCCESS (1.724s)
[117.954438] [029/156] (900s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[118.042964] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[118.046984] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[118.137416] [030/156] (900s left) gem_linear_blits (interruptible)
[118.476113] Starting subtest: interruptible
[122.333381] Subtest interruptible: SUCCESS (3.859s)
[122.481420] [031/156] (896s left) gem_exec_store (basic)
[122.584954] Starting subtest: basic
[122.696726] Subtest basic: SUCCESS (0.114s)
[122.893548] [032/156] (896s left) gem_mmap_gtt (basic-write)
[122.956947] Subtest basic-write: SKIP (0.000s)
[123.020376] [033/156] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[123.112867] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[123.117037] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.192720] [034/156] (895s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[123.249999] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[123.254338] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[123.455115] [035/156] (895s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[123.530082] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[123.534232] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[123.650652] [036/156] (895s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[123.736979] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[123.741449] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[123.820958] [037/156] (895s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt)
[123.916931] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt
[123.921110] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[124.028124] [038/156] (895s left) gem_exec_reloc (basic-gtt-cpu)
[124.098061] Subtest basic-gtt-cpu: SKIP (0.000s)
[124.166191] [039/156] (895s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[124.234037] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[124.238405] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[125.618547] [040/156] (893s left) i915_suspend (fence-restore-untiled)
[125.670308] Starting subtest: fence-restore-untiled
[125.674408] Subtest fence-restore-untiled: SKIP (0.000s)
[125.766882] [041/156] (893s left) prime_vgem (basic-fence-mmap)
[125.828407] Starting subtest: basic-fence-mmap
[125.833046] Subtest basic-fence-mmap: SKIP (0.000s)
[125.932674] [042/156] (893s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[126.014048] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[126.018316] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[126.094297] [043/156] (893s left) sysfs_heartbeat_interval (nopreempt)
[126.155790] Starting subtest: nopreempt
[126.157696] Starting dynamic subtest: vecs0
[136.261205] Dynamic subtest vecs0: SUCCESS (10.106s)
[136.273562] Starting dynamic subtest: ccs0
[140.225967] Dynamic subtest ccs0: SUCCESS (3.961s)
[140.236096] Starting dynamic subtest: vcs0
[150.200648] Dynamic subtest vcs0: SUCCESS (9.970s)
[150.211862] Starting dynamic subtest: bcs0
[154.118752] Dynamic subtest bcs0: SUCCESS (3.919s)
[154.127704] Starting dynamic subtest: rcs0
[158.046894] Dynamic subtest rcs0: SUCCESS (3.928s)
[158.058972] Starting dynamic subtest: vcs1
[166.205791] Dynamic subtest vcs1: SUCCESS (8.154s)
[166.208361] Subtest nopreempt: SUCCESS (40.050s)
[166.280576] [044/156] (853s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[166.369836] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[166.373884] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[166.453161] [045/156] (853s left) kms_cdclk (plane-scaling)
[166.533290] Starting subtest: plane-scaling
[166.535592] Starting dynamic subtest: pipe-A-eDP-1
[166.827817] Dynamic subtest pipe-A-eDP-1: SKIP (0.293s)
[166.837060] Starting dynamic subtest: pipe-B-eDP-1
[166.841740] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[166.850069] Starting dynamic subtest: pipe-C-eDP-1
[166.854689] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[166.863060] Starting dynamic subtest: pipe-D-eDP-1
[166.867652] Dynamic subtest pipe-D-eDP-1: SKIP (0.002s)
[166.871845] Subtest plane-scaling: SKIP (0.301s)
[167.648218] [046/156] (851s left) gem_ctx_engines (execute-allforone)
[167.708054] Starting subtest: execute-allforone
[167.721848] Subtest execute-allforone: SUCCESS (0.014s)
[169.299283] [047/156] (850s left) gem_ctx_persistence (hostile)
[169.356852] Starting subtest: hostile
[179.504271] Subtest hostile: SUCCESS (10.142s)
[179.623701] [048/156] (840s left) i915_drm_fdinfo (busy)
[179.669062] Starting subtest: busy
[179.671301] Starting dynamic subtest: rcs0
[179.699066] Dynamic subtest rcs0: SKIP (0.030s)
[179.707839] Starting dynamic subtest: bcs0
[179.711831] Dynamic subtest bcs0: SKIP (0.001s)
[179.720196] Starting dynamic subtest: vcs0
[179.724486] Dynamic subtest vcs0: SKIP (0.000s)
[179.732618] Starting dynamic subtest: vcs1
[179.736625] Dynamic subtest vcs1: SKIP (0.000s)
[179.744532] Starting dynamic subtest: vecs0
[179.748688] Dynamic subtest vecs0: SKIP (0.000s)
[179.756469] Starting dynamic subtest: ccs0
[179.760521] Dynamic subtest ccs0: SKIP (0.000s)
[179.764387] Subtest busy: SKIP (0.038s)
[179.799774] [049/156] (839s left) perf (gen12-oa-tlb-invalidate)
[179.951384] Starting subtest: gen12-oa-tlb-invalidate
[179.953514] Starting dynamic subtest: 0-rcs0
[189.988117] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[189.997115] Starting dynamic subtest: 1-vcs0
[200.037501] Dynamic subtest 1-vcs0: SUCCESS (10.049s)
[200.040245] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.087s)
[200.083078] [050/156] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[200.161698] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[200.165735] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.260833] [051/156] (819s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[200.346177] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[200.350568] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[200.443641] [052/156] (819s left) kms_psr (psr-cursor-plane-move)
[200.522788] Starting subtest: psr-cursor-plane-move
[200.524915] Starting dynamic subtest: eDP-1
[202.232505] Dynamic subtest eDP-1: SUCCESS (1.708s)
[202.234836] Subtest psr-cursor-plane-move: SUCCESS (1.709s)
[203.110890] [053/156] (816s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[203.185084] Starting subtest: drrs-dirtyfb-ioctl
[203.198554] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[203.297603] [054/156] (816s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[203.383462] Starting subtest: yf-tiled-64bpp-rotate-90
[203.387398] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[203.476197] [055/156] (816s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[203.562276] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[203.566496] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[203.655348] [056/156] (816s left) i915_query (query-topology-kernel-writes)
[203.712801] Starting subtest: query-topology-kernel-writes
[203.714920] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[203.813226] [057/156] (816s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[203.882129] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[203.909895] Starting dynamic subtest: pipe-A-plane-0
[204.318994] Dynamic subtest pipe-A-plane-0: SUCCESS (0.410s)
[204.336185] Starting dynamic subtest: pipe-A-plane-3
[204.641833] Dynamic subtest pipe-A-plane-3: SUCCESS (0.320s)
[205.774967] Starting dynamic subtest: pipe-B-plane-0
[206.190226] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s)
[206.199064] Starting dynamic subtest: pipe-B-plane-3
[206.523270] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[206.839437] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.956s)
[207.652982] [058/156] (812s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[207.753861] Starting subtest: 2x-long-flip-vs-cursor-legacy
[207.758514] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[207.910643] [059/156] (812s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[207.990598] Starting subtest: psr-2p-primscrn-spr-indfb-move
[207.994604] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[208.073012] [060/156] (812s left) kms_invalid_mode (zero-vdisplay)
[208.153040] Starting subtest: zero-vdisplay
[208.155168] Starting dynamic subtest: pipe-A-eDP-1
[208.440717] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[208.450073] Starting dynamic subtest: pipe-B-eDP-1
[208.452561] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[208.461514] Starting dynamic subtest: pipe-C-eDP-1
[208.463968] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[208.471971] Starting dynamic subtest: pipe-D-eDP-1
[208.474284] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[208.476946] Subtest zero-vdisplay: SUCCESS (0.296s)
[209.286488] [061/156] (810s left) gem_ctx_persistence (engines-mixed-process)
[209.339086] Starting subtest: engines-mixed-process
[209.341394] Starting dynamic subtest: rcs0
[211.284817] Dynamic subtest rcs0: SUCCESS (1.945s)
[211.296119] Starting dynamic subtest: bcs0
[213.265779] Dynamic subtest bcs0: SUCCESS (1.979s)
[213.277462] Starting dynamic subtest: vcs0
[215.234689] Dynamic subtest vcs0: SUCCESS (1.967s)
[215.243468] Starting dynamic subtest: vcs1
[217.219788] Dynamic subtest vcs1: SUCCESS (1.984s)
[217.229162] Starting dynamic subtest: vecs0
[219.259589] Dynamic subtest vecs0: SUCCESS (2.038s)
[219.268560] Starting dynamic subtest: ccs0
[221.263531] Dynamic subtest ccs0: SUCCESS (2.002s)
[221.265981] Subtest engines-mixed-process: SUCCESS (11.925s)
[221.342682] [062/156] (798s left) gem_exec_fence (invalid-fence-array)
[221.807756] Starting subtest: invalid-fence-array
[221.810196] Subtest invalid-fence-array: SUCCESS (0.006s)
[223.304691] [063/156] (796s left) kms_cursor_crc (cursor-onscreen-512x170)
[223.583055] Starting subtest: cursor-onscreen-512x170
[223.587535] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[223.710592] [064/156] (796s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[223.802832] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[223.807312] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[223.917898] [065/156] (796s left) kms_addfb_basic (invalid-get-prop)
[223.968969] Starting subtest: invalid-get-prop
[223.971301] Subtest invalid-get-prop: SUCCESS (0.000s)
[224.100926] [066/156] (796s left) kms_flip (modeset-vs-vblank-race-interruptible)
[224.185475] Starting subtest: modeset-vs-vblank-race-interruptible
[224.187863] Starting dynamic subtest: A-eDP1
[229.010083] Dynamic subtest A-eDP1: SUCCESS (4.823s)
[229.024996] Starting dynamic subtest: B-eDP1
[233.827642] Dynamic subtest B-eDP1: SUCCESS (4.814s)
[233.840482] Starting dynamic subtest: C-eDP1
[238.435803] Dynamic subtest C-eDP1: SUCCESS (4.606s)
[238.445091] Starting dynamic subtest: D-eDP1
[243.065774] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[243.068009] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.883s)
[244.240450] [067/156] (776s left) gem_ctx_param (invalid-ctx-get)
[244.287036] Starting subtest: invalid-ctx-get
[244.289561] Subtest invalid-ctx-get: SUCCESS (0.000s)
[244.354412] [068/156] (776s left) syncobj_timeline (wait-for-submit-delayed-submit)
[244.412284] Starting subtest: wait-for-submit-delayed-submit
[244.516160] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[244.593683] [069/156] (775s left) i915_hangman (hangcheck-unterminated)
[244.648114] Starting subtest: hangcheck-unterminated
[255.197699] Subtest hangcheck-unterminated: SUCCESS (10.549s)
[255.330555] [070/156] (765s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[255.413165] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[255.417548] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[255.520144] [071/156] (765s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[255.593424] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[255.598060] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[256.791860] [072/156] (763s left) kms_plane_alpha_blend (alpha-transparent-fb)
[256.855255] Starting subtest: alpha-transparent-fb
[257.138849] Starting dynamic subtest: pipe-A-eDP-1
[257.750483] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[257.760583] Starting dynamic subtest: pipe-D-eDP-1
[259.129292] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.378s)
[259.131471] Subtest alpha-transparent-fb: SUCCESS (2.275s)
[260.035334] [073/156] (760s left) syncobj_timeline (multi-wait-all-signaled)
[260.092748] Starting subtest: multi-wait-all-signaled
[260.095150] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[260.182985] [074/156] (760s left) kms_vblank (query-forked-busy-hang)
[260.260304] Starting subtest: query-forked-busy-hang
[260.262456] Starting dynamic subtest: pipe-A-eDP-1
[286.975706] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.712s)
[286.990233] Starting dynamic subtest: pipe-D-eDP-1
[311.046835] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.067s)
[311.049252] Subtest query-forked-busy-hang: SUCCESS (50.783s)
[311.900027] [075/156] (708s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[311.986282] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[311.994639] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.007s)
[312.071618] [076/156] (708s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[312.150769] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[312.155198] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[312.269015] [077/156] (708s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[312.372551] Starting subtest: flip-vs-cursor-atomic
[319.763085] Subtest flip-vs-cursor-atomic: SUCCESS (7.389s)
[320.614021] [078/156] (700s left) gem_exec_reloc (basic-wc-cpu)
[320.670745] Subtest basic-wc-cpu: SKIP (0.000s)
[320.742174] [079/156] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[320.827697] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[320.832083] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[320.925706] [080/156] (700s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[321.013702] Starting subtest: x-tiled-8bpp-rotate-0
[322.238870] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.225s)
[322.362875] [081/156] (698s left) gem_exec_params (rs-invalid)
[322.419421] Starting subtest: rs-invalid
[322.424555] Subtest rs-invalid: SUCCESS (0.003s)
[322.532352] [082/156] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[322.613482] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[322.616738] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[322.714212] [083/156] (698s left) gem_mmap_gtt (basic-small-copy-xy)
[322.765372] Subtest basic-small-copy-XY: SKIP (0.000s)
[322.819979] [084/156] (698s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[322.865683] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[322.970972] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[323.055474] [085/156] (698s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen)
[323.136422] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen
[323.140677] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[323.233158] [086/156] (698s left) kms_cursor_crc (cursor-sliding-32x10)
[323.384898] Starting subtest: cursor-sliding-32x10
[323.432511] Subtest cursor-sliding-32x10: SKIP (0.042s)
[323.688044] [087/156] (697s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[323.779645] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[323.783611] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[323.890322] [088/156] (697s left) api_intel_allocator (fork-simple-once)
[323.938736] Starting subtest: fork-simple-once
[323.949036] Subtest fork-simple-once: SUCCESS (0.012s)
[324.061335] [089/156] (697s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[324.142873] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[324.146571] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[324.238441] [090/156] (697s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[324.327505] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[324.330933] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[324.423493] [091/156] (697s left) kms_atomic (plane-immutable-zpos)
[324.500079] Starting subtest: plane-immutable-zpos
[324.502516] Starting dynamic subtest: pipe-A-eDP-1
[325.152247] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.650s)
[325.154618] Subtest plane-immutable-zpos: SUCCESS (0.652s)
[325.959290] [092/156] (695s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[326.034303] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[326.038368] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[326.142541] [093/156] (695s left) kms_pm_rpm (i2c)
[328.458808] Starting subtest: i2c
[333.772600] Subtest i2c: SUCCESS (5.317s)
[333.858145] [094/156] (687s left) gem_exec_schedule (preempt-engines)
[333.928079] Starting subtest: preempt-engines
[333.930372] Starting dynamic subtest: rcs0
[336.167155] Dynamic subtest rcs0: SUCCESS (2.248s)
[336.177971] Starting dynamic subtest: bcs0
[338.391419] Dynamic subtest bcs0: SUCCESS (2.220s)
[338.401340] Starting dynamic subtest: vcs0
[340.665871] Dynamic subtest vcs0: SUCCESS (2.274s)
[340.675983] Starting dynamic subtest: vcs1
[342.940262] Dynamic subtest vcs1: SUCCESS (2.272s)
[342.949598] Starting dynamic subtest: vecs0
[345.205358] Dynamic subtest vecs0: SUCCESS (2.262s)
[345.214593] Starting dynamic subtest: ccs0
[347.532802] Dynamic subtest ccs0: SUCCESS (2.325s)
[347.535402] Subtest preempt-engines: SUCCESS (13.614s)
[347.840701] [095/156] (673s left) i915_pm_rpm (sysfs-read)
[349.440501] Starting subtest: sysfs-read
[350.583916] Subtest sysfs-read: SUCCESS (1.145s)
[350.975196] [096/156] (670s left) kms_psr (fbc-pr-cursor-blt)
[351.050320] Starting subtest: fbc-pr-cursor-blt
[351.054591] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[351.164091] [097/156] (670s left) kms_panel_fitting (atomic-fastset)
[351.242989] Starting subtest: atomic-fastset
[351.245237] Starting dynamic subtest: pipe-A-eDP-1
[351.386873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[351.399518] Starting dynamic subtest: pipe-B-eDP-1
[352.632160] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s)
[352.642625] Starting dynamic subtest: pipe-C-eDP-1
[353.831314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s)
[353.842663] Starting dynamic subtest: pipe-D-eDP-1
[355.045959] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[355.048371] Subtest atomic-fastset: SUCCESS (3.805s)
[356.200690] [098/156] (665s left) gem_pxp (fail-invalid-protected-context)
[356.316640] Starting subtest: fail-invalid-protected-context
[356.319337] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[356.419364] [099/156] (665s left) gem_busy (parallel)
[356.602707] Starting subtest: parallel
[356.605062] Starting dynamic subtest: rcs0
[358.206367] Dynamic subtest rcs0: SUCCESS (1.602s)
[358.219942] Starting dynamic subtest: bcs0
[360.254723] Dynamic subtest bcs0: SUCCESS (2.045s)
[360.266124] Starting dynamic subtest: vcs0
[362.239440] Dynamic subtest vcs0: SUCCESS (1.981s)
[362.255548] Starting dynamic subtest: vcs1
[364.221264] Dynamic subtest vcs1: SUCCESS (1.979s)
[364.230929] Starting dynamic subtest: vecs0
[366.207408] Dynamic subtest vecs0: SUCCESS (1.983s)
[366.221104] Starting dynamic subtest: ccs0
[368.254659] Dynamic subtest ccs0: SUCCESS (2.045s)
[368.257425] Subtest parallel: SUCCESS (11.651s)
[368.481311] [100/156] (653s left) gem_watchdog (default-virtual)
[368.545862] Starting subtest: default-virtual
[374.819578] Subtest default-virtual: SUCCESS (6.283s)
[374.917221] [101/156] (646s left) kms_lease (possible-crtcs-filtering)
[374.991962] Starting subtest: possible-crtcs-filtering
[374.996804] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[375.105989] [102/156] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[375.193067] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[375.197070] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.289855] [103/156] (646s left) kms_color (gamma)
[375.378614] Starting subtest: gamma
[375.380900] Starting dynamic subtest: pipe-A-eDP-1
[376.092978] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[376.102530] Starting dynamic subtest: pipe-B-eDP-1
[377.514777] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s)
[377.524231] Starting dynamic subtest: pipe-C-eDP-1
[378.902357] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.385s)
[378.911856] Starting dynamic subtest: pipe-D-eDP-1
[380.335539] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.431s)
[380.337510] Subtest gamma: SUCCESS (4.955s)
[381.143878] [104/156] (640s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[381.197727] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[381.271987] [105/156] (640s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[381.377946] Starting subtest: basic-flip-before-cursor-atomic
[382.297472] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.918s)
[383.180797] [106/156] (638s left) gem_mmap_offset (mmap-boundaries)
[383.237477] Starting subtest: mmap-boundaries
[383.239782] Starting dynamic subtest: smem0
[383.503209] Dynamic subtest smem0: SUCCESS (0.265s)
[383.506038] Subtest mmap-boundaries: SUCCESS (0.266s)
[383.621935] [107/156] (638s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[383.712555] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[383.716668] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[383.817586] [108/156] (638s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[383.900151] Starting subtest: pr-cursor-plane-move-continuous-sf
[383.904508] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[383.964338] [109/156] (638s left) gem_exec_fence (syncobj-invalid-wait)
[384.394601] Starting subtest: syncobj-invalid-wait
[384.397033] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[386.328545] [110/156] (635s left) kms_draw_crc (draw-method-mmap-gtt)
[386.393714] Starting subtest: draw-method-mmap-gtt
[386.397939] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[386.489098] [111/156] (635s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[386.565746] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[386.569953] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[386.637801] [112/156] (635s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[386.719292] Starting subtest: yf-tiled-32bpp-rotate-180
[386.724037] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[386.829323] [113/156] (635s left) kms_frontbuffer_tracking (fbchdr-tiling-linear)
[386.912429] Starting subtest: fbchdr-tiling-linear
[386.916671] Subtest fbchdr-tiling-linear: SKIP (0.000s)
[387.007276] [114/156] (635s left) gen9_exec_parse (basic-rejected)
[387.070411] Subtest basic-rejected: SKIP (0.000s)
[387.136276] [115/156] (635s left) kms_psr (fbc-psr2-primary-render)
[387.211164] Starting subtest: fbc-psr2-primary-render
[387.213449] Starting dynamic subtest: eDP-1
[387.217659] Dynamic subtest eDP-1: SKIP (0.000s)
[387.221961] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[387.284654] [116/156] (635s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-blt)
[387.363717] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-blt
[387.367152] Subtest hdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[387.470923] [117/156] (635s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[387.549218] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area
[387.552742] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[387.614187] [118/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[387.690136] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[387.693865] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[387.781531] [119/156] (634s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[387.851946] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[387.855702] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[387.971440] [120/156] (634s left) kms_addfb_basic (addfb25-4-tiled)
[388.042487] Starting subtest: addfb25-4-tiled
[388.044354] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[388.167130] [121/156] (634s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[388.238861] Starting subtest: y-tiled-8bpp-rotate-0
[388.242671] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[388.341050] [122/156] (634s left) kms_pm_backlight (fade-with-suspend)
[388.408086] Starting subtest: fade-with-suspend
[404.377661] Starting dynamic subtest: eDP-1
[407.390117] Dynamic subtest eDP-1: SUCCESS (3.067s)
[407.392516] Subtest fade-with-suspend: SUCCESS (4.473s)
[408.205561] [123/156] (614s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[408.317333] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite
[408.321586] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[408.420815] [124/156] (614s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[408.476732] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[408.586136] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.109s)
[408.661116] [125/156] (614s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[408.742121] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[408.744044] Starting dynamic subtest: pipe-A-eDP-1
[410.038218] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.311s)
[410.320427] Starting dynamic subtest: pipe-B-eDP-1
[411.355597] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.055s)
[411.627207] Subtest plane-all-modeset-transition-fencing-internal-panels: SUCCESS (2.918s)
[412.481316] [126/156] (610s left) gem_mmap_gtt (big-copy-xy)
[412.535874] Subtest big-copy-XY: SKIP (0.000s)
[412.589748] [127/156] (610s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[412.668914] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[412.671088] Starting dynamic subtest: pipe-A-eDP-1
[412.690521] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[412.700356] Starting dynamic subtest: pipe-B-eDP-1
[412.719493] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[412.729606] Starting dynamic subtest: pipe-C-eDP-1
[412.747649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[412.757116] Starting dynamic subtest: pipe-D-eDP-1
[412.776573] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[412.778760] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[414.910411] [128/156] (608s left) kms_chamelium_hpd (vga-hpd)
[415.278856] Subtest vga-hpd: SKIP (0.000s)
[416.133040] [129/156] (606s left) perf_pmu (rc6-suspend)
[416.177214] Starting subtest: rc6-suspend
[438.516127] Subtest rc6-suspend: SUCCESS (7.606s)
[439.542174] [130/156] (583s left) kms_properties (invalid-properties-legacy)
[439.629770] Starting subtest: invalid-properties-legacy
[439.720068] Subtest invalid-properties-legacy: SUCCESS (0.092s)
[439.794835] [131/156] (583s left) kms_flip (2x-flip-vs-panning-interruptible)
[439.870222] Starting subtest: 2x-flip-vs-panning-interruptible
[439.877353] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.007s)
[439.971919] [132/156] (583s left) syncobj_wait (invalid-signal-one-illegal-handle)
[440.018759] Starting subtest: invalid-signal-one-illegal-handle
[440.021115] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[440.114956] [133/156] (583s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[440.189191] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[441.301771] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[441.432501] [134/156] (581s left) kms_cursor_crc (cursor-random-64x64)
[441.575122] Starting subtest: cursor-random-64x64
[441.579845] Starting dynamic subtest: pipe-A-eDP-1
[444.900795] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.347s)
[444.932949] Starting dynamic subtest: pipe-D-eDP-1
[448.903418] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[448.905760] Subtest cursor-random-64x64: SUCCESS (7.373s)
[449.726106] [135/156] (573s left) prime_vgem (coherency-blt)
[449.794516] Starting subtest: coherency-blt
[450.847480] Subtest coherency-blt: SUCCESS (1.057s)
[450.961153] [136/156] (572s left) kms_psr (fbc-psr-primary-mmap-cpu)
[451.036636] Starting subtest: fbc-psr-primary-mmap-cpu
[451.039329] Starting dynamic subtest: eDP-1
[451.044384] Dynamic subtest eDP-1: SKIP (0.000s)
[451.049594] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[451.107539] [137/156] (572s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[451.178921] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[451.181459] Starting dynamic subtest: pipe-A-eDP-1
[451.238064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[451.248825] Starting dynamic subtest: pipe-B-eDP-1
[451.297486] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.058s)
[451.308073] Starting dynamic subtest: pipe-C-eDP-1
[451.352804] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.057s)
[451.363707] Starting dynamic subtest: pipe-D-eDP-1
[451.411500] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.058s)
[451.414162] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.235s)
[453.677563] [138/156] (569s left) gem_ctx_shared (q-promotion)
[453.738489] Starting subtest: Q-promotion
[453.740917] Starting dynamic subtest: rcs0
[453.851455] Dynamic subtest rcs0: SUCCESS (0.111s)
[453.874244] Starting dynamic subtest: vcs0
[453.943537] Dynamic subtest vcs0: SUCCESS (0.093s)
[453.960550] Starting dynamic subtest: vcs1
[454.021298] Dynamic subtest vcs1: SUCCESS (0.077s)
[454.039038] Starting dynamic subtest: vecs0
[454.099436] Dynamic subtest vecs0: SUCCESS (0.077s)
[454.118896] Starting dynamic subtest: ccs0
[454.179347] Dynamic subtest ccs0: SUCCESS (0.079s)
[454.182056] Subtest Q-promotion: SUCCESS (0.442s)
[455.709245] [139/156] (567s left) gem_softpin (allocator-evict)
[455.774037] Starting subtest: allocator-evict
[455.776670] Starting dynamic subtest: rcs0
[479.668570] Dynamic subtest rcs0: SUCCESS (23.900s)
[479.680946] Starting dynamic subtest: bcs0
[503.438200] Dynamic subtest bcs0: SUCCESS (23.767s)
[503.452035] Starting dynamic subtest: vcs0
[527.180890] Dynamic subtest vcs0: SUCCESS (23.748s)
[527.192929] Starting dynamic subtest: vcs1
[550.976512] Dynamic subtest vcs1: SUCCESS (23.789s)
[550.988790] Starting dynamic subtest: vecs0
[574.576360] Dynamic subtest vecs0: SUCCESS (23.596s)
[574.588276] Starting dynamic subtest: ccs0
[598.158172] Dynamic subtest ccs0: SUCCESS (23.582s)
[598.160902] Subtest allocator-evict: SUCCESS (142.392s)
[598.242354] [140/156] (425s left) kms_flip (flip-vs-dpms-on-nop)
[598.372403] Starting subtest: flip-vs-dpms-on-nop
[598.374782] Starting dynamic subtest: A-eDP1
[600.250687] Dynamic subtest A-eDP1: SUCCESS (1.881s)
[600.266488] Starting dynamic subtest: B-eDP1
[602.086169] Dynamic subtest B-eDP1: SUCCESS (1.833s)
[602.100395] Starting dynamic subtest: C-eDP1
[603.916139] Dynamic subtest C-eDP1: SUCCESS (1.828s)
[603.926833] Starting dynamic subtest: D-eDP1
[605.745909] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[605.748694] Subtest flip-vs-dpms-on-nop: SUCCESS (7.381s)
[606.935049] [141/156] (416s left) sw_sync (sync_expired_merge)
[606.991784] Starting subtest: sync_expired_merge
[608.067360] Subtest sync_expired_merge: SUCCESS (1.074s)
[608.130445] [142/156] (415s left) gem_ctx_param (non-root-set)
[608.184922] Starting subtest: non-root-set
[608.206987] Subtest non-root-set: SUCCESS (0.022s)
[608.297577] [143/156] (415s left) kms_content_protection (atomic-dpms)
[608.423191] Starting subtest: atomic-dpms
[608.428638] Subtest atomic-dpms: SKIP (0.000s)
[608.546618] [144/156] (415s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[608.618565] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[608.621113] Starting dynamic subtest: pipe-A
[608.968654] Dynamic subtest pipe-A: SUCCESS (0.353s)
[608.978956] Starting dynamic subtest: pipe-B
[610.435603] Dynamic subtest pipe-B: SUCCESS (1.466s)
[610.446392] Starting dynamic subtest: pipe-C
[611.878224] Dynamic subtest pipe-C: SUCCESS (1.442s)
[611.888509] Starting dynamic subtest: pipe-D
[613.286382] Dynamic subtest pipe-D: SUCCESS (1.408s)
[613.288831] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.672s)
[614.450145] [145/156] (409s left) gem_eio (in-flight-contexts-10ms)
[614.680695] Starting subtest: in-flight-contexts-10ms
[628.621486] Subtest in-flight-contexts-10ms: SUCCESS (13.944s)
[628.758345] [146/156] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[628.856054] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[636.202311] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SUCCESS (7.355s)
[636.330672] [147/156] (387s left) core_getversion (basic)
[636.367782] Starting subtest: basic
[636.373165] Subtest basic: SUCCESS (0.000s)
[636.436814] [148/156] (387s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[636.506756] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[636.531592] Starting dynamic subtest: pipe-A-plane-0
[636.832005] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[636.843504] Starting dynamic subtest: pipe-A-plane-3
[637.077556] Dynamic subtest pipe-A-plane-3: SUCCESS (0.242s)
[638.159715] Starting dynamic subtest: pipe-B-plane-0
[638.450112] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[638.461373] Starting dynamic subtest: pipe-B-plane-3
[638.683560] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[639.009796] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.504s)
[639.855215] [149/156] (383s left) gem_exec_schedule (u-fairslice)
[639.936261] Starting subtest: u-fairslice
[639.938760] Starting dynamic subtest: rcs0
[641.949855] Dynamic subtest rcs0: SUCCESS (2.022s)
[641.960041] Starting dynamic subtest: bcs0
[643.968689] Dynamic subtest bcs0: SUCCESS (2.018s)
[643.981079] Starting dynamic subtest: vcs0
[645.991310] Dynamic subtest vcs0: SUCCESS (2.021s)
[646.006790] Starting dynamic subtest: vcs1
[648.013710] Dynamic subtest vcs1: SUCCESS (2.024s)
[648.024453] Starting dynamic subtest: vecs0
[650.034330] Dynamic subtest vecs0: SUCCESS (2.020s)
[650.045286] Starting dynamic subtest: ccs0
[652.057706] Dynamic subtest ccs0: SUCCESS (2.023s)
[652.060341] Subtest u-fairslice: SUCCESS (12.133s)
[652.357754] [150/156] (371s left) gem_exec_balancer (full-late)
[652.417214] Starting subtest: full-late
[657.437813] Subtest full-late: SUCCESS (5.022s)
[657.740096] [151/156] (366s left) kms_flip (flip-vs-panning-interruptible)
[657.813803] Starting subtest: flip-vs-panning-interruptible
[657.816495] Starting dynamic subtest: A-eDP1
[666.567718] Dynamic subtest A-eDP1: SUCCESS (8.753s)
[666.578615] Starting dynamic subtest: B-eDP1
[675.285903] Dynamic subtest B-eDP1: SUCCESS (8.713s)
[675.298027] Starting dynamic subtest: C-eDP1
[684.007241] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[684.019391] Starting dynamic subtest: D-eDP1
[692.743376] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[692.745769] Subtest flip-vs-panning-interruptible: SUCCESS (34.927s)
[693.903929] [152/156] (330s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[694.001387] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[697.966419] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.971s)
[699.118958] [153/156] (324s left) gem_render_copy (yf-tiled-ccs-to-linear)
[699.186677] Starting subtest: yf-tiled-ccs-to-linear
[699.191667] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[699.368440] [154/156] (324s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[699.454816] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[699.459684] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[699.542040] [155/156] (324s left) sw_sync (alloc_fence_invalid_timeline)
[699.579675] Starting subtest: alloc_fence_invalid_timeline
[699.582388] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[699.628769] [156/156] (324s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[699.703425] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[704.124192] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.430s)
[705.300980] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_ctx_create
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_lmem_swapping
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_vrr
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_chamelium_edid
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_rotation_crc
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: vgem_slow
results: parsing output: 22/ for test: kms_force_connector_basic
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_prop_blob
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_linear_blits
results: parsing output: 30/ for test: gem_exec_store
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: i915_suspend
results: parsing output: 40/ for test: prime_vgem
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: sysfs_heartbeat_interval
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cdclk
results: parsing output: 45/ for test: gem_ctx_engines
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_dirtyfb
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_query
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_invalid_mode
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: gem_exec_fence
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_plane_alpha_blend
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: gem_exec_reloc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_exec_params
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: api_intel_allocator
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_atomic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_pm_rpm
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: i915_pm_rpm
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_panel_fitting
results: parsing output: 97/ for test: gem_pxp
results: parsing output: 98/ for test: gem_busy
results: parsing output: 99/ for test: gem_watchdog
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_color
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_psr2_sf
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: syncobj_wait
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_cursor_crc
results: parsing output: 134/ for test: prime_vgem
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_ccs
results: parsing output: 137/ for test: gem_ctx_shared
results: parsing output: 138/ for test: gem_softpin
results: parsing output: 139/ for test: kms_flip
results: parsing output: 140/ for test: sw_sync
results: parsing output: 141/ for test: gem_ctx_param
results: parsing output: 142/ for test: kms_content_protection
results: parsing output: 143/ for test: kms_plane_scaling
results: parsing output: 144/ for test: gem_eio
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: core_getversion
results: parsing output: 147/ for test: kms_plane
results: parsing output: 148/ for test: gem_exec_schedule
results: parsing output: 149/ for test: gem_exec_balancer
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_render_copy
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: sw_sync
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.