[57.000393] Initializing watchdogs
[57.000442]   /dev/watchdog0
[57.014924] [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]
[57.019453] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.021789] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.025666] [001/156] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[57.155643] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[57.159964] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.249981] [002/156] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-pgflip-blt)
[57.344508] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-pgflip-blt
[57.348606] Subtest fbcpsrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[57.435827] [003/156] (960s left) gem_exec_schedule (noreorder-priority)
[57.612878] Starting subtest: noreorder-priority
[57.615269] Starting dynamic subtest: rcs0
[58.753688] Dynamic subtest rcs0: SUCCESS (1.149s)
[58.761369] Starting dynamic subtest: vcs0
[60.286805] Dynamic subtest vcs0: SUCCESS (1.540s)
[60.296484] Starting dynamic subtest: vcs1
[62.276480] Dynamic subtest vcs1: SUCCESS (1.999s)
[62.286616] Starting dynamic subtest: vecs0
[64.326392] Dynamic subtest vecs0: SUCCESS (2.056s)
[64.336524] Starting dynamic subtest: ccs0
[65.482991] Dynamic subtest ccs0: SUCCESS (1.161s)
[65.485786] Subtest noreorder-priority: SUCCESS (7.911s)
[65.679345] [004/156] (951s left) kms_chamelium_edid (dp-edid-resolution-list)
[66.069349] Subtest dp-edid-resolution-list: SKIP (0.000s)
[66.884466] [005/156] (950s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-render)
[66.995544] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-render
[66.999578] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[67.107213] [006/156] (950s left) kms_joiner (basic-max-non-joiner)
[67.210484] Starting subtest: basic-max-non-joiner
[67.215085] Subtest basic-max-non-joiner: SKIP (0.000s)
[67.273933] [007/156] (950s left) gen9_exec_parse (shadow-peek)
[67.336287] Subtest shadow-peek: SKIP (0.000s)
[67.401914] [008/156] (950s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[67.465125] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[67.566532] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[67.637411] [009/156] (950s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[67.740194] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[67.744590] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[67.817367] [010/156] (950s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[67.907114] Starting subtest: 2x-plain-flip-ts-check-interruptible
[67.921197] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.013s)
[68.018304] [011/156] (949s left) gem_exec_whisper (basic-contexts-priority)
[68.086999] Starting subtest: basic-contexts-priority
[92.753195] Subtest basic-contexts-priority: SUCCESS (24.676s)
[92.936341] [012/156] (924s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[93.036545] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[93.041202] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[93.116442] [013/156] (924s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[93.221751] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[93.226172] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[93.322038] [014/156] (924s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[93.418050] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[93.420381] Starting dynamic subtest: pipe-A-eDP-1
[94.156339] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.729s)
[94.165990] Starting dynamic subtest: pipe-B-eDP-1
[96.035881] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.879s)
[96.045736] Starting dynamic subtest: pipe-C-eDP-1
[97.857475] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.821s)
[97.867158] Starting dynamic subtest: pipe-D-eDP-1
[99.675793] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.818s)
[99.678298] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.251s)
[100.810596] [015/156] (917s left) i915_module_load (resize-bar)
[100.849873] Starting subtest: resize-bar
[100.859229] Subtest resize-bar: SKIP (0.006s)
[100.896273] [016/156] (917s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[100.986318] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[107.565890] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.586s)
[107.700321] [017/156] (910s left) i915_query (query-topology-kernel-writes)
[107.746621] Starting subtest: query-topology-kernel-writes
[107.748492] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[107.848985] [018/156] (910s left) syncobj_basic (test-valid-cycle)
[107.896021] Starting subtest: test-valid-cycle
[107.898054] Subtest test-valid-cycle: SUCCESS (0.000s)
[107.973393] [019/156] (910s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[108.065074] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[108.067323] Starting dynamic subtest: pipe-A-eDP-1
[108.929925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.859s)
[108.939766] Starting dynamic subtest: pipe-B-eDP-1
[110.517297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.584s)
[110.527081] Starting dynamic subtest: pipe-C-eDP-1
[112.083658] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.566s)
[112.094205] Starting dynamic subtest: pipe-D-eDP-1
[113.612715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[113.614644] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.541s)
[114.877752] [020/156] (903s left) kms_atomic_transition (plane-all-transition)
[114.968242] Starting subtest: plane-all-transition
[114.970648] Starting dynamic subtest: pipe-A-eDP-1
[117.461134] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[117.779230] Starting dynamic subtest: pipe-B-eDP-1
[121.003531] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.235s)
[121.313093] Subtest plane-all-transition: SUCCESS (6.345s)
[122.137587] [021/156] (896s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[122.246361] Starting subtest: x-tiled-addfb-size-offset-overflow
[122.248242] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[122.347978] [022/156] (895s left) syncobj_timeline (invalid-wait-illegal-handle)
[122.410404] Starting subtest: invalid-wait-illegal-handle
[122.412500] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[122.521809] [023/156] (895s left) kms_plane_scaling (invalid-num-scalers)
[122.608307] Starting subtest: invalid-num-scalers
[122.610722] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[122.624599] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.018s)
[122.633806] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[122.657939] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[122.667755] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[122.691366] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[122.699687] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[122.723542] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.031s)
[122.725674] Subtest invalid-num-scalers: SUCCESS (0.117s)
[122.812152] [024/156] (895s left) syncobj_wait (wait-for-submit-delayed-submit)
[122.864071] Starting subtest: wait-for-submit-delayed-submit
[122.967110] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[123.056355] [025/156] (895s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[123.158550] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[123.815713] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[123.968445] [026/156] (894s left) i915_pm_rc6_residency (rc6-fence)
[124.028479] Starting subtest: rc6-fence
[124.055877] Starting dynamic subtest: gt0
[136.372738] Dynamic subtest gt0: SUCCESS (12.316s)
[136.384566] Starting dynamic subtest: gt1
[151.326858] Dynamic subtest gt1: SUCCESS (14.923s)
[151.329617] Subtest rc6-fence: SUCCESS (27.273s)
[151.381786] [027/156] (867s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-wc)
[151.486780] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-wc
[151.491214] Subtest fbcpsrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[151.575594] [028/156] (866s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[151.676090] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[151.680281] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[151.746251] [029/156] (866s left) kms_flip (2x-wf_vblank-ts-check)
[151.841095] Starting subtest: 2x-wf_vblank-ts-check
[151.849611] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[151.937774] [030/156] (866s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[152.032430] Starting subtest: plane-lut1d-ctm3x4
[152.178374] Starting dynamic subtest: pipe-A-plane-0
[152.366533] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[152.376116] Starting dynamic subtest: pipe-A-plane-1
[152.513069] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[152.521665] Starting dynamic subtest: pipe-A-plane-2
[152.688774] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s)
[153.948425] Starting dynamic subtest: pipe-B-plane-0
[154.102279] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[154.111239] Starting dynamic subtest: pipe-B-plane-1
[154.282131] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s)
[154.294038] Starting dynamic subtest: pipe-B-plane-2
[154.436810] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[155.682809] Starting dynamic subtest: pipe-C-plane-0
[155.808562] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[155.817816] Starting dynamic subtest: pipe-C-plane-1
[155.987746] Dynamic subtest pipe-C-plane-1: SUCCESS (0.177s)
[155.997698] Starting dynamic subtest: pipe-C-plane-2
[156.120029] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[157.339265] Starting dynamic subtest: pipe-D-plane-0
[157.472881] Dynamic subtest pipe-D-plane-0: SUCCESS (0.143s)
[157.483057] Starting dynamic subtest: pipe-D-plane-1
[157.628088] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[157.639872] Starting dynamic subtest: pipe-D-plane-2
[157.795704] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[158.081068] Subtest plane-lut1d-ctm3x4: SUCCESS (6.049s)
[158.963929] [031/156] (859s left) gem_exec_params (secure-non-master)
[159.036149] Starting subtest: secure-non-master
[159.041029] Subtest secure-non-master: SKIP (0.000s)
[159.149052] [032/156] (859s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[159.523588] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[160.374020] [033/156] (858s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[160.469384] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[160.471430] Starting dynamic subtest: pipe-A-eDP-1
[160.610027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[160.621238] Starting dynamic subtest: pipe-B-eDP-1
[160.640953] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[160.649253] Starting dynamic subtest: pipe-C-eDP-1
[160.668737] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[160.677685] Starting dynamic subtest: pipe-D-eDP-1
[160.697168] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[160.699072] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.140s)
[162.875356] [034/156] (855s left) gem_exec_params (invalid-flag)
[162.937866] Starting subtest: invalid-flag
[162.939802] Subtest invalid-flag: SUCCESS (0.000s)
[163.052606] [035/156] (855s left) gem_ctx_exec (basic)
[163.110396] Starting subtest: basic
[163.115241] Subtest basic: SUCCESS (0.005s)
[163.235561] [036/156] (855s left) kms_atomic_interruptible (atomic-setmode)
[163.325838] Starting subtest: atomic-setmode
[163.328672] Starting dynamic subtest: pipe-A-eDP-1
[170.227630] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.901s)
[170.230077] Subtest atomic-setmode: SUCCESS (6.902s)
[171.111091] [037/156] (847s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[171.214487] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[171.218687] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[171.334087] [038/156] (847s left) kms_prime (basic-crc-hybrid)
[171.410432] Subtest basic-crc-hybrid: SKIP (0.000s)
[171.559545] [FACT kms_prime (basic-crc-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[171.562835] [039/156] (847s left) kms_cursor_edge_walk (256x256-top-edge)
[171.657225] Starting subtest: 256x256-top-edge
[171.659545] Starting dynamic subtest: pipe-A-eDP-1
[175.078716] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.423s)
[175.088830] Starting dynamic subtest: pipe-D-eDP-1
[178.213344] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[178.215607] Subtest 256x256-top-edge: SUCCESS (6.558s)
[179.037345] [040/156] (839s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[179.135192] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[179.137448] Starting dynamic subtest: pipe-A-eDP-1
[179.146499] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.155230] Starting dynamic subtest: pipe-B-eDP-1
[179.163843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.172072] Starting dynamic subtest: pipe-C-eDP-1
[179.180199] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.188425] Starting dynamic subtest: pipe-D-eDP-1
[179.196730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.200749] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[181.389381] [041/156] (837s left) gem_userptr_blits (unsync-unmap-cycles)
[181.450986] Subtest unsync-unmap-cycles: SKIP (0.000s)
[181.572241] [042/156] (837s left) gem_exec_reloc (basic-gtt-read-noreloc)
[181.629603] Subtest basic-gtt-read-noreloc: SKIP (0.000s)
[181.711845] [043/156] (837s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[181.808862] Starting subtest: primary-yf-tiled-reflect-x-0
[181.879624] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.070s)
[181.983600] [044/156] (837s left) kms_atomic_transition (modeset-transition-fencing)
[182.078263] Starting subtest: modeset-transition-fencing
[182.080137] Starting dynamic subtest: 1x-outputs
[193.214225] Dynamic subtest 1x-outputs: SUCCESS (11.137s)
[193.216657] Subtest modeset-transition-fencing: SUCCESS (11.138s)
[194.077915] [045/156] (825s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[194.189505] Starting subtest: cursorA-vs-flipB-atomic-transitions
[194.194136] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[194.336840] [046/156] (824s left) gen3_render_tiledx_blits
[194.462704] [047/156] (824s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[194.564091] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[198.630337] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.072s)
[199.787821] [048/156] (819s left) vgem_basic (sysfs)
[199.837870] Starting subtest: sysfs
[199.840052] Subtest sysfs: SUCCESS (0.000s)
[199.893865] [049/156] (819s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[199.988340] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[199.990567] Starting dynamic subtest: pipe-A-eDP-1
[211.302654] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.318s)
[211.311981] Starting dynamic subtest: pipe-B-eDP-1
[223.299043] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.992s)
[223.300896] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.314s)
[224.167166] [050/156] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[224.267317] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[224.271941] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[224.377893] [051/156] (795s left) kms_vblank (query-forked)
[224.469394] Starting subtest: query-forked
[224.471368] Starting dynamic subtest: pipe-A-eDP-1
[226.277830] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[226.291293] Starting dynamic subtest: pipe-D-eDP-1
[228.840554] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[228.843093] Subtest query-forked: SUCCESS (4.373s)
[229.701990] [052/156] (789s left) gem_mmap_offset (bad-extensions)
[229.748044] Starting subtest: bad-extensions
[229.750445] Subtest bad-extensions: SUCCESS (0.000s)
[229.839678] [053/156] (789s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[232.473476] Starting subtest: dpms-mode-unset-lpsp
[236.546630] Subtest dpms-mode-unset-lpsp: SUCCESS (4.074s)
[236.944783] [054/156] (782s left) gem_ctx_shared (q-out-order)
[237.008390] Starting subtest: Q-out-order
[237.010766] Starting dynamic subtest: rcs0
[237.112656] Dynamic subtest rcs0: SUCCESS (0.103s)
[237.130044] Starting dynamic subtest: vcs0
[237.193365] Dynamic subtest vcs0: SUCCESS (0.080s)
[237.209071] Starting dynamic subtest: vcs1
[237.266190] Dynamic subtest vcs1: SUCCESS (0.073s)
[237.281763] Starting dynamic subtest: vecs0
[237.346411] Dynamic subtest vecs0: SUCCESS (0.079s)
[237.364743] Starting dynamic subtest: ccs0
[237.436409] Dynamic subtest ccs0: SUCCESS (0.089s)
[237.438838] Subtest Q-out-order: SUCCESS (0.428s)
[238.354298] [055/156] (781s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[238.446884] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[238.451345] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[238.543954] [056/156] (781s left) gem_exec_fence (basic-await)
[238.716079] Starting subtest: basic-await
[238.718141] Starting dynamic subtest: rcs0
[238.788357] Dynamic subtest rcs0: SUCCESS (0.075s)
[238.802180] Starting dynamic subtest: bcs0
[238.862288] Dynamic subtest bcs0: SUCCESS (0.072s)
[238.874569] Starting dynamic subtest: vcs0
[238.935302] Dynamic subtest vcs0: SUCCESS (0.071s)
[238.947802] Starting dynamic subtest: vcs1
[239.008029] Dynamic subtest vcs1: SUCCESS (0.071s)
[239.021034] Starting dynamic subtest: vecs0
[239.081793] Dynamic subtest vecs0: SUCCESS (0.071s)
[239.093867] Starting dynamic subtest: ccs0
[239.154139] Dynamic subtest ccs0: SUCCESS (0.071s)
[239.156641] Subtest basic-await: SUCCESS (0.442s)
[241.349689] [057/156] (778s left) gem_exec_nop (basic-sequential)
[241.426594] Starting subtest: basic-sequential
[255.816553] Subtest basic-sequential: SUCCESS (14.398s)
[256.052189] [058/156] (763s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[256.146053] Starting subtest: primary-4-tiled-reflect-x-180
[263.131480] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.988s)
[264.297574] [059/156] (755s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[264.405051] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[264.409137] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[264.503308] [060/156] (755s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[264.605972] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite
[264.610193] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[264.705484] [061/156] (755s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[264.818075] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[266.276661] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.458s)
[267.163405] [062/156] (752s left) kms_content_protection (lic-type-0)
[267.304809] Starting subtest: lic-type-0
[267.309286] Subtest lic-type-0: SKIP (0.000s)
[267.452433] [063/156] (752s left) api_intel_allocator (simple-allocator)
[267.515380] Starting subtest: simple-allocator
[267.517363] Starting dynamic subtest: basic
[267.520413] Dynamic subtest basic: SUCCESS (0.004s)
[267.532220] Starting dynamic subtest: parallel-one
[267.682847] Dynamic subtest parallel-one: SUCCESS (0.164s)
[267.694069] Starting dynamic subtest: print
[267.696960] Dynamic subtest print: SUCCESS (0.000s)
[267.708940] Starting dynamic subtest: reuse
[267.711261] Dynamic subtest reuse: SUCCESS (0.000s)
[267.720172] Starting dynamic subtest: reserve
[267.722410] Dynamic subtest reserve: SUCCESS (0.000s)
[267.731315] Starting dynamic subtest: fork-reopen-allocator
[267.733640] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[267.735954] Subtest simple-allocator: SUCCESS (0.183s)
[267.826495] [064/156] (752s left) syncobj_eventfd (invalid-bad-flags)
[267.878646] Starting subtest: invalid-bad-flags
[267.880666] Subtest invalid-bad-flags: SUCCESS (0.000s)
[267.999400] [065/156] (752s left) gem_pread (bench)
[268.050061] Subtest bench: SKIP (0.000s)
[268.111524] [066/156] (752s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[268.202882] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[268.207059] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[268.311256] [067/156] (751s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt)
[268.413081] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt
[268.417274] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[268.496295] [068/156] (751s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[268.588839] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[268.593292] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[268.662999] [069/156] (751s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[268.755424] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[268.758942] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[268.862203] [070/156] (751s left) gem_exec_fence (syncobj-timeline-wait)
[269.408793] Starting subtest: syncobj-timeline-wait
[270.300974] Subtest syncobj-timeline-wait: SUCCESS (0.896s)
[272.409636] [071/156] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[272.510831] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[272.514967] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[272.622835] [072/156] (747s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[272.736160] Starting subtest: fbcpsrhdr-tiling-4
[272.740258] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[272.831290] [073/156] (747s left) kms_psr (psr2-primary-mmap-cpu)
[272.922436] Starting subtest: psr2-primary-mmap-cpu
[272.924764] Starting dynamic subtest: eDP-1
[274.645492] Dynamic subtest eDP-1: SUCCESS (1.723s)
[274.647640] Subtest psr2-primary-mmap-cpu: SUCCESS (1.724s)
[275.534486] [074/156] (744s left) gem_caching (reads)
[275.597376] Subtest reads: SKIP (0.000s)
[275.675346] [075/156] (744s left) gen7_exec_parse (basic-allocation)
[275.736624] Subtest basic-allocation: SKIP (0.000s)
[275.806986] [076/156] (744s left) syncobj_timeline (etime-single-wait-submitted)
[275.855718] Starting subtest: etime-single-wait-submitted
[275.960311] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[276.034501] [077/156] (744s left) perf (global-sseu-config-invalid)
[276.155581] Starting subtest: global-sseu-config-invalid
[276.160014] Subtest global-sseu-config-invalid: SKIP (0.000s)
[276.201401] [078/156] (744s left) gem_ccs (suspend-resume)
[276.255844] Starting subtest: suspend-resume
[276.260360] Subtest suspend-resume: SKIP (0.000s)
[276.350640] [079/156] (744s left) core_auth (getclient-master-drop)
[276.388206] Starting subtest: getclient-master-drop
[276.402084] Subtest getclient-master-drop: SUCCESS (0.016s)
[276.499356] [080/156] (744s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[276.595067] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[276.599213] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[276.704655] [081/156] (744s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[276.796830] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[276.801170] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[276.894318] [082/156] (743s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[276.944060] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[277.044924] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[277.131177] [083/156] (743s left) perf (invalid-oa-metric-set-id)
[277.220130] Starting subtest: invalid-oa-metric-set-id
[277.233670] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[277.273062] [084/156] (743s left) syncobj_timeline (wait-for-submit-snapshot)
[277.326478] Starting subtest: wait-for-submit-snapshot
[277.406798] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[277.482224] [085/156] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[277.569254] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[281.124040] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.558s)
[282.348077] [086/156] (738s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[282.446680] Starting subtest: 4-tiled-64bpp-rotate-270
[282.466166] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[282.617850] [087/156] (738s left) prime_self_import (basic-llseek-bad)
[282.652061] Starting subtest: basic-llseek-bad
[282.672731] Subtest basic-llseek-bad: SUCCESS (0.020s)
[282.778656] [088/156] (738s left) kms_psr (fbc-pr-sprite-plane-onoff)
[282.865541] Starting subtest: fbc-pr-sprite-plane-onoff
[282.869640] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[282.938449] [089/156] (738s left) gem_exec_balancer (hog)
[283.008245] Starting subtest: hog
[283.013086] Subtest hog: SKIP (0.000s)
[283.319031] [090/156] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[283.415336] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[290.773647] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.362s)
[290.910087] [091/156] (730s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[291.005105] Starting subtest: addfb25-y-tiled-legacy
[291.006950] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[291.103536] [092/156] (730s left) dumb_buffer (create-clear)
[291.152825] Starting subtest: create-clear
[324.968863] Subtest create-clear: SUCCESS (33.811s)
[325.087032] [093/156] (696s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[325.195450] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[328.773900] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.585s)
[329.984850] [094/156] (691s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[330.083234] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[330.087378] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[330.185315] [095/156] (691s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[330.236568] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[330.240900] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[330.418951] [096/156] (691s left) gem_close_race (basic-process)
[330.476050] Starting subtest: basic-process
[330.539968] Subtest basic-process: SUCCESS (0.064s)
[330.738045] [097/156] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[330.847629] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[330.852199] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[330.959379] [098/156] (690s left) gem_eio (wait-immediate)
[331.181932] Starting subtest: wait-immediate
[331.546967] Subtest wait-immediate: SUCCESS (0.367s)
[331.698959] [099/156] (689s left) kms_frontbuffer_tracking (psr-1p-rte)
[331.807341] Starting subtest: psr-1p-rte
[337.150938] Subtest psr-1p-rte: SUCCESS (5.349s)
[337.275846] [100/156] (684s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite)
[337.395323] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite
[337.399964] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[337.485693] [101/156] (684s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move)
[337.574571] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move
[337.578732] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[337.700663] [102/156] (683s left) kms_big_fb (linear-16bpp-rotate-180)
[337.791067] Starting subtest: linear-16bpp-rotate-180
[339.181066] Subtest linear-16bpp-rotate-180: SUCCESS (1.390s)
[339.293416] [103/156] (682s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[339.386065] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[339.389483] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[339.481330] [104/156] (682s left) gem_huc_copy (huc-copy)
[339.532805] Starting subtest: huc-copy
[339.536598] Subtest huc-copy: SUCCESS (0.003s)
[339.674724] [105/156] (682s left) kms_lease (invalid-create-leases)
[339.764242] Starting subtest: invalid-create-leases
[339.768569] Subtest invalid-create-leases: SUCCESS (0.005s)
[339.873041] [106/156] (681s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[339.978589] Starting subtest: yf-tiled-64bpp-rotate-270
[339.982415] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[340.076091] [107/156] (681s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[340.179471] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[340.183031] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[340.283478] [108/156] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[340.380202] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[340.383571] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[340.475941] [109/156] (681s left) syncobj_timeline (reset-during-wait-for-submit)
[340.529081] Starting subtest: reset-during-wait-for-submit
[340.634258] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[340.722371] [110/156] (681s left) kms_psr (pr-sprite-plane-onoff)
[340.811484] Starting subtest: pr-sprite-plane-onoff
[340.815535] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[340.886461] [111/156] (681s left) intel_hwmon (hwmon-read)
[340.936472] Subtest hwmon-read: SKIP (0.000s)
[340.997456] [112/156] (681s left) gem_exec_schedule (reorder-wide)
[341.171402] Subtest reorder-wide: SKIP (0.000s)
[341.350663] [113/156] (680s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[341.439711] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[341.443954] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[341.538586] [114/156] (680s left) i915_query (query-topology-coherent-slice-mask)
[341.591826] Starting subtest: query-topology-coherent-slice-mask
[341.596173] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[341.709856] [115/156] (680s left) kms_rotation_crc (sprite-rotation-90)
[341.806327] Starting subtest: sprite-rotation-90
[341.810863] Subtest sprite-rotation-90: SKIP (0.001s)
[341.874118] [116/156] (680s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[341.981057] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[341.985142] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[342.079916] [117/156] (680s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[342.180473] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[342.184724] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[342.276378] [118/156] (680s left) gem_ctx_persistence (engines-hostile-preempt)
[342.340810] Starting subtest: engines-hostile-preempt
[342.343027] Starting dynamic subtest: rcs0
[342.441606] Dynamic subtest rcs0: SUCCESS (0.100s)
[342.452753] Starting dynamic subtest: bcs0
[342.486214] Dynamic subtest bcs0: SUCCESS (0.042s)
[342.497126] Starting dynamic subtest: vcs0
[344.324659] Dynamic subtest vcs0: SUCCESS (1.834s)
[344.337233] Starting dynamic subtest: vcs1
[346.291785] Dynamic subtest vcs1: SUCCESS (1.951s)
[346.304063] Starting dynamic subtest: vecs0
[348.287780] Dynamic subtest vecs0: SUCCESS (2.008s)
[348.300784] Starting dynamic subtest: ccs0
[348.336523] Dynamic subtest ccs0: SUCCESS (0.048s)
[348.338908] Subtest engines-hostile-preempt: SUCCESS (5.996s)
[348.442672] [119/156] (673s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[348.509840] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[348.514425] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[348.698265] [120/156] (673s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[348.792158] Starting subtest: fbc-psr-sprite-mmap-cpu
[348.794341] Starting dynamic subtest: eDP-1
[348.798663] Dynamic subtest eDP-1: SKIP (0.000s)
[348.802954] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[348.864538] [121/156] (673s left) gem_softpin (full)
[348.921780] Starting subtest: full
[348.929640] Subtest full: SUCCESS (0.008s)
[349.054239] [122/156] (673s left) gem_exec_params (batch-first)
[349.099965] Starting subtest: batch-first
[349.103421] Subtest batch-first: SUCCESS (0.006s)
[349.248116] [123/156] (673s left) gem_exec_suspend (basic)
[349.302718] Starting subtest: basic
[349.305471] Starting dynamic subtest: smem
[351.298614] Dynamic subtest smem: SUCCESS (1.994s)
[351.301351] Subtest basic: SUCCESS (1.996s)
[351.499802] [124/156] (671s left) sysfs_preempt_timeout (invalid)
[351.571380] Starting subtest: invalid
[351.573749] Starting dynamic subtest: vecs0
[351.576079] Dynamic subtest vecs0: SUCCESS (0.000s)
[351.586776] Starting dynamic subtest: ccs0
[351.588695] Dynamic subtest ccs0: SUCCESS (0.000s)
[351.597487] Starting dynamic subtest: vcs0
[351.599402] Dynamic subtest vcs0: SUCCESS (0.000s)
[351.608109] Starting dynamic subtest: bcs0
[351.609996] Dynamic subtest bcs0: SUCCESS (0.000s)
[351.618654] Starting dynamic subtest: rcs0
[351.620610] Dynamic subtest rcs0: SUCCESS (0.000s)
[351.629599] Starting dynamic subtest: vcs1
[351.631716] Dynamic subtest vcs1: SUCCESS (0.000s)
[351.633843] Subtest invalid: SUCCESS (0.005s)
[351.696911] [125/156] (670s left) kms_force_connector_basic (force-edid)
[351.775995] Starting subtest: force-edid
[352.144832] Subtest force-edid: SUCCESS (0.369s)
[352.284761] [126/156] (670s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[352.379917] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[352.383366] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[352.480637] [127/156] (670s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[352.573686] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[352.575566] Starting dynamic subtest: pipe-A-eDP-1
[352.596883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.607808] Starting dynamic subtest: pipe-B-eDP-1
[352.627537] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.636734] Starting dynamic subtest: pipe-C-eDP-1
[352.656659] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.666574] Starting dynamic subtest: pipe-D-eDP-1
[352.687059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.690802] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[354.823282] [128/156] (667s left) kms_dsc (dsc-fractional-bpp)
[354.913469] Starting subtest: dsc-fractional-bpp
[354.926444] Subtest dsc-fractional-bpp: SKIP (0.000s)
[354.982713] [129/156] (667s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[355.079064] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[359.741429] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.666s)
[359.874960] [130/156] (662s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[359.973642] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[366.841988] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.873s)
[366.983696] [131/156] (655s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[367.084788] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[367.087571] Starting dynamic subtest: pipe-A
[367.105605] Dynamic subtest pipe-A: SKIP (0.017s)
[367.117285] Starting dynamic subtest: pipe-B
[367.136322] Dynamic subtest pipe-B: SKIP (0.030s)
[367.146535] Starting dynamic subtest: pipe-C
[367.167068] Dynamic subtest pipe-C: SKIP (0.030s)
[367.178721] Starting dynamic subtest: pipe-D
[367.196526] Dynamic subtest pipe-D: SKIP (0.030s)
[367.200983] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.110s)
[367.324896] [132/156] (655s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[367.450333] Starting subtest: cursorA-vs-flipA-toggle
[378.577297] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s)
[379.428457] [133/156] (643s left) gem_exec_fence (submit)
[379.598664] Starting subtest: submit
[379.603576] Subtest submit: SKIP (0.000s)
[381.389389] [134/156] (641s left) kms_vblank (ts-continuation-idle)
[381.475153] Starting subtest: ts-continuation-idle
[381.477052] Starting dynamic subtest: pipe-A-eDP-1
[381.870844] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[381.885254] Starting dynamic subtest: pipe-D-eDP-1
[382.973824] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.101s)
[382.976507] Subtest ts-continuation-idle: SUCCESS (1.500s)
[383.815993] [135/156] (639s left) gem_exec_reloc (basic-wc-cpu-active)
[383.871694] Subtest basic-wc-cpu-active: SKIP (0.000s)
[383.950929] [136/156] (639s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[384.056639] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[384.060724] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[384.159858] [137/156] (638s left) gem_userptr_blits (unsync-overlap)
[384.219596] Subtest unsync-overlap: SKIP (0.000s)
[384.342811] [138/156] (638s left) perf_pmu (init-sema)
[384.379775] Starting subtest: init-sema
[384.381972] Starting dynamic subtest: rcs0
[384.384261] Dynamic subtest rcs0: SUCCESS (0.001s)
[384.393513] Starting dynamic subtest: bcs0
[384.395373] Dynamic subtest bcs0: SUCCESS (0.000s)
[384.403958] Starting dynamic subtest: vcs0
[384.405819] Dynamic subtest vcs0: SUCCESS (0.000s)
[384.414614] Starting dynamic subtest: vcs1
[384.416505] Dynamic subtest vcs1: SUCCESS (0.001s)
[384.425148] Starting dynamic subtest: vecs0
[384.427258] Dynamic subtest vecs0: SUCCESS (0.000s)
[384.439166] Starting dynamic subtest: ccs0
[384.441289] Dynamic subtest ccs0: SUCCESS (0.000s)
[384.443147] Subtest init-sema: SUCCESS (0.008s)
[384.491339] [139/156] (638s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[384.547061] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[384.606248] [140/156] (638s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-plflip-blt)
[384.692791] Starting subtest: psrhdr-1p-primscrn-indfb-plflip-blt
[384.696980] Subtest psrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[384.786168] [141/156] (638s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt)
[384.884038] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt
[384.887573] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[384.972051] [142/156] (638s left) gem_ccs (block-multicopy-inplace)
[385.037954] Starting subtest: block-multicopy-inplace
[385.041860] Subtest block-multicopy-inplace: SKIP (0.000s)
[385.136575] [143/156] (638s left) kms_psr2_su (page_flip-p010)
[385.181175] Subtest page_flip-P010: SKIP (0.000s)
[385.239460] [144/156] (638s left) kms_big_fb (y-tiled-addfb-size-overflow)
[385.328656] Starting subtest: y-tiled-addfb-size-overflow
[385.332405] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[385.420971] [145/156] (638s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[385.527259] Starting subtest: psrhdr-rgb565-draw-pwrite
[385.530889] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[385.620852] [146/156] (637s left) syncobj_basic (bad-destroy-pad)
[385.667742] Starting subtest: bad-destroy-pad
[385.669528] Subtest bad-destroy-pad: SUCCESS (0.000s)
[385.772858] [147/156] (637s left) kms_cursor_legacy (torture-bo)
[385.886724] Starting subtest: torture-bo
[385.888743] Starting dynamic subtest: pipe-A
[392.401104] Dynamic subtest pipe-A: SUCCESS (6.513s)
[392.419465] Starting dynamic subtest: pipe-B
[399.292083] Dynamic subtest pipe-B: SUCCESS (6.890s)
[399.305717] Starting dynamic subtest: pipe-C
[405.805699] Dynamic subtest pipe-C: SUCCESS (6.512s)
[405.815631] Starting dynamic subtest: pipe-D
[412.459155] Dynamic subtest pipe-D: SUCCESS (6.650s)
[412.471153] Starting dynamic subtest: all-pipes
[418.523222] Dynamic subtest all-pipes: SUCCESS (6.062s)
[418.525980] Subtest torture-bo: SUCCESS (32.638s)
[418.681570] [148/156] (604s left) kms_cursor_crc (cursor-random-128x128)
[418.887451] Starting subtest: cursor-random-128x128
[418.892296] Starting dynamic subtest: pipe-A-eDP-1
[422.231054] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.340s)
[422.261430] Starting dynamic subtest: pipe-D-eDP-1
[426.289928] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.035s)
[426.292528] Subtest cursor-random-128x128: SUCCESS (7.401s)
[427.114596] [149/156] (596s left) gem_ctx_persistence (hostile)
[427.169241] Starting subtest: hostile
[436.669932] Subtest hostile: SUCCESS (9.498s)
[436.800830] [150/156] (586s left) kms_plane_multiple (tiling-4)
[436.900306] Starting subtest: tiling-4
[436.902643] Starting dynamic subtest: pipe-A-eDP-1
[440.780471] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.878s)
[440.790402] Starting dynamic subtest: pipe-B-eDP-1
[445.350971] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.570s)
[445.363667] Starting dynamic subtest: pipe-C-eDP-1
[449.931836] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.582s)
[449.942800] Starting dynamic subtest: pipe-D-eDP-1
[454.527565] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.594s)
[454.530235] Subtest tiling-4: SUCCESS (17.628s)
[455.427067] [151/156] (568s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[455.582043] Starting subtest: cursor-rapid-movement-32x32
[455.626542] Subtest cursor-rapid-movement-32x32: SKIP (0.041s)
[455.915062] [152/156] (567s left) kms_flip (nonexisting-fb)
[456.010972] Starting subtest: nonexisting-fb
[456.013259] Starting dynamic subtest: A-eDP1
[457.176483] Dynamic subtest A-eDP1: SUCCESS (1.166s)
[457.186931] Starting dynamic subtest: B-eDP1
[458.379068] Dynamic subtest B-eDP1: SUCCESS (1.202s)
[458.389688] Starting dynamic subtest: C-eDP1
[459.574753] Dynamic subtest C-eDP1: SUCCESS (1.195s)
[459.588812] Starting dynamic subtest: D-eDP1
[460.771415] Dynamic subtest D-eDP1: SUCCESS (1.193s)
[460.773832] Subtest nonexisting-fb: SUCCESS (4.766s)
[461.951820] [153/156] (561s left) kms_plane_alpha_blend (alpha-opaque-fb)
[462.048352] Starting subtest: alpha-opaque-fb
[462.333423] Starting dynamic subtest: pipe-A-eDP-1
[462.986633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.652s)
[462.997369] Starting dynamic subtest: pipe-D-eDP-1
[464.309715] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[464.311879] Subtest alpha-opaque-fb: SUCCESS (2.264s)
[465.118156] [154/156] (558s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[465.215670] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[465.219983] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[465.331476] [155/156] (558s left) syncobj_wait (multi-wait-all-submitted)
[465.387262] Starting subtest: multi-wait-all-submitted
[465.495081] Subtest multi-wait-all-submitted: SUCCESS (0.108s)
[465.584550] [156/156] (558s left) i915_drm_fdinfo (virtual-busy-hang-all)
[465.619039] Starting subtest: virtual-busy-hang-all
[465.624182] Subtest virtual-busy-hang-all: SKIP (0.000s)
[465.677090] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_chamelium_edid
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_joiner
results: parsing output: 6/ for test: gen9_exec_parse
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_plane
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: i915_module_load
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_query
results: parsing output: 17/ for test: syncobj_basic
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_atomic_transition
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: i915_pm_rc6_residency
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_color_pipeline
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gem_ctx_exec
results: parsing output: 35/ for test: kms_atomic_interruptible
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_prime
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_userptr_blits
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_rotation_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gen3_render_tiledx_blits
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: gem_exec_nop
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: api_intel_allocator
results: parsing output: 63/ for test: syncobj_eventfd
results: parsing output: 64/ for test: gem_pread
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: gem_caching
results: parsing output: 74/ for test: gen7_exec_parse
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_ccs
results: parsing output: 78/ for test: core_auth
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: perf
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: prime_self_import
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: dumb_buffer
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: gem_close_race
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_huc_copy
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_query
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_ctx_persistence
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: gem_exec_suspend
results: parsing output: 123/ for test: sysfs_preempt_timeout
results: parsing output: 124/ for test: kms_force_connector_basic
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_dsc
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_exec_fence
results: parsing output: 133/ for test: kms_vblank
results: parsing output: 134/ for test: gem_exec_reloc
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: gem_userptr_blits
results: parsing output: 137/ for test: perf_pmu
results: parsing output: 138/ for test: gem_mmap_gtt
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_ccs
results: parsing output: 142/ for test: kms_psr2_su
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: syncobj_basic
results: parsing output: 146/ for test: kms_cursor_legacy
results: parsing output: 147/ for test: kms_cursor_crc
results: parsing output: 148/ for test: gem_ctx_persistence
results: parsing output: 149/ for test: kms_plane_multiple
results: parsing output: 150/ for test: kms_cursor_crc
results: parsing output: 151/ for test: kms_flip
results: parsing output: 152/ for test: kms_plane_alpha_blend
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: syncobj_wait
results: parsing output: 155/ for test: i915_drm_fdinfo
Done.