[59.315428] Initializing watchdogs
[59.315478]   /dev/watchdog0
[59.330566] [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]
[59.335232] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.337469] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.340802] [001/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[59.469748] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[59.474183] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[59.612145] [002/134] (960s left) i915_pm_rps (fence-order)
[59.681576] Starting subtest: fence-order
[63.122499] Subtest fence-order: SUCCESS (3.423s)
[63.282149] [003/134] (956s left) kms_psr (psr-sprite-mmap-cpu)
[63.376770] Starting subtest: psr-sprite-mmap-cpu
[63.379125] Starting dynamic subtest: eDP-1
[65.402667] Dynamic subtest eDP-1: SUCCESS (2.019s)
[65.404988] Subtest psr-sprite-mmap-cpu: SUCCESS (2.020s)
[66.270914] [004/134] (953s left) api_intel_bb (blit-noreloc-purge-cache)
[66.335677] Starting subtest: blit-noreloc-purge-cache
[66.345802] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[66.491967] [005/134] (953s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[66.605972] Starting subtest: x-tiled-64bpp-rotate-270
[66.625043] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[66.854524] [006/134] (953s left) gem_ctx_shared (detached-shared-gtt)
[66.952846] Starting subtest: detached-shared-gtt
[69.110327] Subtest detached-shared-gtt: SUCCESS (2.151s)
[69.475962] [007/134] (950s left) perf (whitelisted-registers-userspace-config)
[69.611848] Starting subtest: whitelisted-registers-userspace-config
[69.614036] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[69.664899] [008/134] (950s left) kms_selftest (drm_damage_helper)
[69.703982] Starting subtest: drm_damage_helper
[69.717769] Starting dynamic subtest: drm_test_damage_iter_no_damage
[69.843231] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.125s)
[69.852245] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[69.954437] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.109s)
[69.964029] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[70.075263] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.120s)
[70.084630] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[70.212322] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.137s)
[70.221446] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[70.327844] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.115s)
[70.335032] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[70.447198] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.119s)
[70.456714] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[70.547271] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.099s)
[70.556458] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[70.664981] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.118s)
[70.672255] Starting dynamic subtest: drm_test_damage_iter_single_damage
[70.800883] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.135s)
[70.808084] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[70.892088] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.091s)
[70.899293] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[70.989331] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.097s)
[70.996649] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[71.077221] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.087s)
[71.084688] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[71.212973] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.134s)
[71.220215] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[71.333190] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.120s)
[71.340354] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[71.472976] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.140s)
[71.480212] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[71.588188] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.115s)
[71.597469] Starting dynamic subtest: drm_test_damage_iter_damage
[71.706446] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.116s)
[71.715978] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[71.831245] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.123s)
[71.839060] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[71.954084] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.124s)
[71.961625] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[72.084935] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.129s)
[72.093636] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[72.193074] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.108s)
[72.195485] Subtest drm_damage_helper: SUCCESS (2.484s)
[72.388175] [009/134] (947s left) gem_exec_flush (basic-wb-rw-default)
[72.441389] Starting subtest: basic-wb-rw-default
[77.902428] Subtest basic-wb-rw-default: SUCCESS (5.457s)
[78.109672] [010/134] (942s left) syncobj_timeline (invalid-transfer-illegal-handle)
[78.178280] Starting subtest: invalid-transfer-illegal-handle
[78.180700] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[78.319066] [011/134] (941s left) perf (oa-formats)
[78.428510] Starting subtest: oa-formats
[78.430944] Starting dynamic subtest: 0-rcs0
[78.445938] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[78.457466] Starting dynamic subtest: 1-vcs1
[78.472628] Dynamic subtest 1-vcs1: SUCCESS (0.026s)
[78.474775] Subtest oa-formats: SUCCESS (0.045s)
[78.513354] [012/134] (941s left) perf_pmu (rc6)
[78.560600] Starting subtest: rc6
[78.562417] Starting dynamic subtest: gt0
[84.948686] Dynamic subtest gt0: SUCCESS (6.383s)
[84.958811] Starting dynamic subtest: runtime-pm-gt0
[92.670580] Dynamic subtest runtime-pm-gt0: SUCCESS (7.717s)
[92.680503] Starting dynamic subtest: runtime-pm-long-gt0
[105.121789] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.446s)
[105.132314] Starting dynamic subtest: other-idle-gt0
[111.464938] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[111.475703] Starting dynamic subtest: gt1
[117.806337] Dynamic subtest gt1: SUCCESS (6.339s)
[117.816950] Starting dynamic subtest: runtime-pm-gt1
[125.243304] Dynamic subtest runtime-pm-gt1: SUCCESS (7.435s)
[125.254241] Starting dynamic subtest: runtime-pm-long-gt1
[137.664738] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.419s)
[137.675502] Starting dynamic subtest: other-idle-gt1
[144.006970] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[144.009758] Subtest rc6: SUCCESS (65.430s)
[145.168624] [013/134] (875s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[150.172561] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[150.175076] Starting dynamic subtest: pipe-A-eDP-1
[156.803352] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.628s)
[156.813339] Starting dynamic subtest: pipe-B-eDP-1
[163.427668] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.621s)
[163.430132] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.253s)
[164.288988] [014/134] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[164.400365] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[171.813966] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.416s)
[171.927307] [015/134] (848s left) gem_softpin (allocator-nopin-reserve)
[171.984530] Starting subtest: allocator-nopin-reserve
[172.097430] Subtest allocator-nopin-reserve: SUCCESS (0.111s)
[172.188278] [016/134] (848s left) gem_pxp (fail-invalid-protected-context)
[172.309283] Starting subtest: fail-invalid-protected-context
[172.311745] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[172.399339] [017/134] (848s left) fbdev (read)
[172.453070] Starting subtest: read
[172.980649] Subtest read: SUCCESS (0.529s)
[173.017888] [018/134] (847s left) gem_exec_params (rsvd2-dirt)
[173.082337] Starting subtest: rsvd2-dirt
[173.086805] Subtest rsvd2-dirt: SKIP (0.000s)
[173.164847] [019/134] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[173.257832] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[173.261718] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[173.322990] [020/134] (847s left) gem_exec_fence (invalid-timeline-fence-array)
[173.887234] Starting subtest: invalid-timeline-fence-array
[173.893170] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[175.002045] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[175.005390] [021/134] (845s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[175.116721] Starting subtest: invalid-modeset-force-ultra-joiner
[175.120777] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[175.162623] [022/134] (845s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[175.268057] Starting subtest: fbcpsr-modesetfrombusy
[181.504694] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.240s)
[181.630660] [023/134] (839s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[181.731145] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[181.733041] Starting dynamic subtest: pipe-A-eDP-1
[181.751442] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[181.759966] Starting dynamic subtest: pipe-B-eDP-1
[181.777924] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[181.785493] Starting dynamic subtest: pipe-C-eDP-1
[181.803019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[181.810912] Starting dynamic subtest: pipe-D-eDP-1
[181.828112] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[181.831483] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[183.931569] [024/134] (836s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[184.034314] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[188.116275] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.086s)
[189.225588] [025/134] (831s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[189.278866] Starting subtest: multi-wait-for-submit-submitted-signaled
[189.281291] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[189.355653] [026/134] (831s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[189.448511] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[189.450801] Starting dynamic subtest: pipe-A-eDP-1
[189.508089] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[189.518135] Starting dynamic subtest: pipe-B-eDP-1
[189.573392] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[189.583465] Starting dynamic subtest: pipe-C-eDP-1
[189.639592] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[189.649501] Starting dynamic subtest: pipe-D-eDP-1
[189.706286] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[189.710183] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.010s)
[191.693475] [027/134] (829s left) kms_cursor_crc (cursor-random-64x21)
[191.887034] Starting subtest: cursor-random-64x21
[191.932434] Subtest cursor-random-64x21: SKIP (0.043s)
[192.149423] [028/134] (828s left) gem_pread (snoop)
[192.199748] Subtest snoop: SKIP (0.000s)
[192.260798] [029/134] (828s left) drm_read (short-buffer-block)
[192.426858] Starting subtest: short-buffer-block
[192.429490] Subtest short-buffer-block: SUCCESS (0.000s)
[192.531761] [030/134] (828s left) i915_hangman (engine-engine-error)
[192.598449] Starting subtest: engine-engine-error
[192.600487] Starting dynamic subtest: rcs0
[193.908349] Dynamic subtest rcs0: SUCCESS (1.309s)
[193.919138] Starting dynamic subtest: bcs0
[195.892493] Dynamic subtest bcs0: SUCCESS (1.982s)
[195.903948] Starting dynamic subtest: vcs0
[197.874697] Dynamic subtest vcs0: SUCCESS (1.980s)
[197.886333] Starting dynamic subtest: vcs1
[199.795780] Dynamic subtest vcs1: SUCCESS (1.919s)
[199.807456] Starting dynamic subtest: vecs0
[200.882862] Dynamic subtest vecs0: SUCCESS (1.086s)
[200.893896] Starting dynamic subtest: ccs0
[202.867191] Dynamic subtest ccs0: SUCCESS (1.982s)
[202.870354] Subtest engine-engine-error: SUCCESS (10.268s)
[202.926588] [031/134] (818s left) kms_prime (basic-crc-vgem)
[203.017233] Starting subtest: basic-crc-vgem
[203.019607] Starting dynamic subtest: second-to-first
[204.004156] Dynamic subtest second-to-first: SUCCESS (0.991s)
[204.006043] Subtest basic-crc-vgem: SUCCESS (0.992s)
[204.051991] [032/134] (816s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[204.182797] Starting subtest: plane-downscale-factor-0-5-with-rotation
[204.184646] Starting dynamic subtest: pipe-A
[204.203968] Dynamic subtest pipe-A: SKIP (0.017s)
[204.214398] Starting dynamic subtest: pipe-B
[204.235925] Dynamic subtest pipe-B: SKIP (0.031s)
[204.244742] Starting dynamic subtest: pipe-C
[204.267703] Dynamic subtest pipe-C: SKIP (0.031s)
[204.275668] Starting dynamic subtest: pipe-D
[204.298781] Dynamic subtest pipe-D: SKIP (0.031s)
[204.301845] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.111s)
[204.378747] [033/134] (816s left) kms_content_protection (srm)
[204.516802] Starting subtest: srm
[204.523310] Subtest srm: SKIP (0.002s)
[204.627974] [034/134] (816s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[204.725689] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[205.815732] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.500s)
[205.855350] [035/134] (815s left) kms_psr (pr-sprite-plane-onoff)
[205.948836] Starting subtest: pr-sprite-plane-onoff
[205.953077] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[206.010840] [036/134] (815s left) tools_test (sysfs_l3_parity)
[206.052534] Starting subtest: sysfs_l3_parity
[206.131678] Subtest sysfs_l3_parity: SKIP (0.087s)
[206.165524] [037/134] (815s left) kms_plane_cursor (primary)
[206.258618] Starting subtest: primary
[206.262531] Starting dynamic subtest: pipe-A-eDP-1-size-64
[208.846843] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.589s)
[208.869828] Starting dynamic subtest: pipe-A-eDP-1-size-128
[211.415371] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.551s)
[211.442502] Starting dynamic subtest: pipe-A-eDP-1-size-256
[213.972050] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[214.287715] Starting dynamic subtest: pipe-B-eDP-1-size-64
[217.633907] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.356s)
[217.658062] Starting dynamic subtest: pipe-B-eDP-1-size-128
[220.191111] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[220.215257] Starting dynamic subtest: pipe-B-eDP-1-size-256
[222.770320] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.561s)
[223.087080] Starting dynamic subtest: pipe-C-eDP-1-size-64
[225.963350] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.884s)
[225.992898] Starting dynamic subtest: pipe-C-eDP-1-size-128
[228.186309] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.202s)
[228.212084] Starting dynamic subtest: pipe-C-eDP-1-size-256
[230.442376] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s)
[230.757999] Starting dynamic subtest: pipe-D-eDP-1-size-64
[233.683339] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.934s)
[233.709253] Starting dynamic subtest: pipe-D-eDP-1-size-128
[235.894373] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[235.921132] Starting dynamic subtest: pipe-D-eDP-1-size-256
[238.150571] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.235s)
[238.462906] Subtest primary: SUCCESS (32.201s)
[239.326436] [038/134] (781s left) syncobj_timeline (signal)
[239.382173] Starting subtest: signal
[239.384069] Subtest signal: SUCCESS (0.000s)
[239.476076] [039/134] (781s left) gem_ctx_isolation (preservation-reset)
[239.666911] Starting subtest: preservation-reset
[239.669183] Starting dynamic subtest: rcs0
[239.954940] Dynamic subtest rcs0: SUCCESS (0.291s)
[239.966082] Starting dynamic subtest: bcs0
[240.304998] Dynamic subtest bcs0: SUCCESS (0.349s)
[240.316811] Starting dynamic subtest: vcs0
[240.638375] Dynamic subtest vcs0: SUCCESS (0.333s)
[240.650065] Starting dynamic subtest: vcs1
[242.259229] Dynamic subtest vcs1: SUCCESS (1.619s)
[242.269385] Starting dynamic subtest: vecs0
[244.242549] Dynamic subtest vecs0: SUCCESS (1.982s)
[244.251683] Starting dynamic subtest: ccs0
[246.231318] Dynamic subtest ccs0: SUCCESS (1.988s)
[246.233797] Subtest preservation-reset: SUCCESS (6.570s)
[246.372169] [040/134] (775s left) kms_cursor_crc (cursor-offscreen-512x512)
[246.654555] Starting subtest: cursor-offscreen-512x512
[246.659036] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[246.808665] [041/134] (774s left) syncobj_wait (wait-all-interrupted)
[246.869157] Starting subtest: wait-all-interrupted
[246.971986] Subtest wait-all-interrupted: SUCCESS (0.102s)
[247.023980] [042/134] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[247.135934] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[247.140203] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[247.219591] [043/134] (774s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[247.273067] Starting subtest: invalid-multi-wait-unsubmitted
[247.275269] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[247.360704] [044/134] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[247.466697] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[252.054240] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.592s)
[253.214849] [045/134] (768s left) kms_getfb (getfb2-accept-nv12)
[253.318459] Starting subtest: getfb2-accept-nv12
[253.320650] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[253.408859] [046/134] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[253.518389] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[257.155920] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.643s)
[258.312385] [047/134] (763s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[258.414385] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[258.418652] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[258.501881] [048/134] (763s left) i915_drm_fdinfo (isolation)
[258.544817] Starting subtest: isolation
[258.546709] Starting dynamic subtest: rcs0
[258.568074] Dynamic subtest rcs0: SKIP (0.022s)
[258.577310] Starting dynamic subtest: bcs0
[258.586056] Dynamic subtest bcs0: SKIP (0.016s)
[258.597349] Starting dynamic subtest: vcs0
[258.601468] Dynamic subtest vcs0: SKIP (0.001s)
[258.610636] Starting dynamic subtest: vcs1
[258.614984] Dynamic subtest vcs1: SKIP (0.000s)
[258.623616] Starting dynamic subtest: vecs0
[258.627983] Dynamic subtest vecs0: SKIP (0.000s)
[258.636554] Starting dynamic subtest: ccs0
[258.640896] Dynamic subtest ccs0: SKIP (0.000s)
[258.645176] Subtest isolation: SKIP (0.046s)
[258.682807] [049/134] (763s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[258.757793] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[258.835347] [050/134] (762s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[258.945122] Starting subtest: 4-tiled-addfb-size-offset-overflow
[258.946997] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[259.042518] [051/134] (762s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[259.135561] Starting subtest: disable-crc-after-crtc
[259.137807] Starting dynamic subtest: pipe-A-eDP-1
[260.771779] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.636s)
[260.783585] Starting dynamic subtest: pipe-B-eDP-1
[263.045411] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.271s)
[263.055599] Starting dynamic subtest: pipe-C-eDP-1
[265.299860] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.252s)
[265.309940] Starting dynamic subtest: pipe-D-eDP-1
[267.558822] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.258s)
[267.561162] Subtest disable-crc-after-crtc: SUCCESS (8.423s)
[268.374638] [052/134] (753s left) perf_pmu (busy-hang)
[268.417026] Starting subtest: busy-hang
[268.419215] Starting dynamic subtest: rcs0
[269.720723] Dynamic subtest rcs0: SUCCESS (1.300s)
[269.731387] Starting dynamic subtest: bcs0
[270.972212] Dynamic subtest bcs0: SUCCESS (1.252s)
[270.983734] Starting dynamic subtest: vcs0
[273.438233] Dynamic subtest vcs0: SUCCESS (2.461s)
[273.448469] Starting dynamic subtest: vcs1
[275.422864] Dynamic subtest vcs1: SUCCESS (1.983s)
[275.433919] Starting dynamic subtest: vecs0
[277.404034] Dynamic subtest vecs0: SUCCESS (1.982s)
[277.415739] Starting dynamic subtest: ccs0
[278.665051] Dynamic subtest ccs0: SUCCESS (1.256s)
[278.666934] Subtest busy-hang: SUCCESS (10.245s)
[278.763394] [053/134] (743s left) gem_mmap_gtt (basic-short)
[278.837368] Subtest basic-short: SKIP (0.000s)
[278.914225] [054/134] (743s left) gem_exec_whisper (basic-contexts-forked-all)
[278.981625] Starting subtest: basic-contexts-forked-all
[301.984897] Subtest basic-contexts-forked-all: SUCCESS (22.998s)
[302.147853] [055/134] (719s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[302.546183] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[303.395029] [056/134] (718s left) kms_flip (2x-plain-flip-ts-check)
[303.500864] Starting subtest: 2x-plain-flip-ts-check
[303.509407] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[303.614066] [057/134] (718s left) gem_exec_balancer (busy)
[303.680854] Starting subtest: busy
[304.939319] Subtest busy: SUCCESS (1.257s)
[305.235574] [058/134] (716s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[305.320748] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[305.322996] Starting dynamic subtest: pipe-A-default-mode
[305.625239] Dynamic subtest pipe-A-default-mode: SKIP (0.299s)
[305.629809] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.301s)
[306.442867] [059/134] (715s left) gem_exec_capture (capture-invisible)
[306.509798] Starting subtest: capture-invisible
[306.511829] Starting dynamic subtest: smem0
[306.516102] Dynamic subtest smem0: SKIP (0.000s)
[306.520363] Subtest capture-invisible: SKIP (0.001s)
[306.599422] [060/134] (715s left) kms_vblank (wait-idle)
[306.694739] Starting subtest: wait-idle
[306.696984] Starting dynamic subtest: pipe-A-eDP-1
[308.461856] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[308.481378] Starting dynamic subtest: pipe-D-eDP-1
[310.916900] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.451s)
[310.918904] Subtest wait-idle: SUCCESS (4.221s)
[311.711172] [061/134] (710s left) gem_exec_reloc (basic-range-active)
[311.777877] Subtest basic-range-active: SKIP (0.000s)
[311.859698] [062/134] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[311.961638] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[319.143305] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.183s)
[319.236929] [063/134] (703s left) kms_pm_rpm (fences)
[321.091746] Starting subtest: fences
[321.096926] Subtest fences: SKIP (0.000s)
[321.490478] [064/134] (700s left) perf (short-reads)
[321.553726] Starting subtest: short-reads
[321.565229] Subtest short-reads: SUCCESS (0.012s)
[321.618088] [065/134] (700s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-cpu)
[321.728323] Starting subtest: psr-abgr161616f-draw-mmap-cpu
[321.732236] Subtest psr-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[321.813029] [066/134] (700s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[321.911314] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[321.915320] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[322.007403] [067/134] (700s left) kms_psr (fbc-psr-sprite-render)
[322.104691] Starting subtest: fbc-psr-sprite-render
[322.106925] Starting dynamic subtest: eDP-1
[322.111162] Dynamic subtest eDP-1: SKIP (0.000s)
[322.115299] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[322.166145] [068/134] (700s left) kms_pm_dc (dc5-dpms-negative)
[323.264049] Starting subtest: dc5-dpms-negative
[323.268303] Subtest dc5-dpms-negative: SKIP (0.000s)
[323.311831] [069/134] (699s left) syncobj_timeline (wait-zero-handles)
[323.366049] Starting subtest: wait-zero-handles
[323.368233] Subtest wait-zero-handles: SUCCESS (0.000s)
[323.451360] [070/134] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[323.552066] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[323.556404] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[323.622429] [071/134] (699s left) kms_vblank (wait-forked)
[323.719092] Starting subtest: wait-forked
[323.721157] Starting dynamic subtest: pipe-A-eDP-1
[325.518020] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.798s)
[325.532333] Starting dynamic subtest: pipe-D-eDP-1
[327.990235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[327.992380] Subtest wait-forked: SUCCESS (4.271s)
[328.835685] [072/134] (693s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[328.894975] Starting subtest: single-wait-all-for-submit-unsubmitted
[329.000945] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[329.052401] [073/134] (693s left) vgem_basic (bad-fence)
[329.096359] Starting subtest: bad-fence
[329.098882] Subtest bad-fence: SUCCESS (0.000s)
[329.141762] [074/134] (693s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[329.241735] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[329.246084] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[329.318901] [075/134] (693s left) kms_flip (bo-too-big-interruptible)
[329.412072] Starting subtest: bo-too-big-interruptible
[329.414184] Starting dynamic subtest: A-eDP1
[330.702250] Dynamic subtest A-eDP1: SUCCESS (1.289s)
[330.711492] Starting dynamic subtest: B-eDP1
[331.943595] Dynamic subtest B-eDP1: SUCCESS (1.240s)
[331.954763] Starting dynamic subtest: C-eDP1
[333.275772] Dynamic subtest C-eDP1: SUCCESS (1.330s)
[333.287056] Starting dynamic subtest: D-eDP1
[334.509895] Dynamic subtest D-eDP1: SUCCESS (1.233s)
[334.512198] Subtest bo-too-big-interruptible: SUCCESS (5.100s)
[335.703125] [076/134] (687s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[335.796844] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[335.799216] Starting dynamic subtest: pipe-A-default-mode
[338.573814] Dynamic subtest pipe-A-default-mode: SUCCESS (2.777s)
[338.576057] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.778s)
[339.390519] [077/134] (683s left) gem_exec_schedule (implicit-write-read)
[339.474743] Starting subtest: implicit-write-read
[339.477047] Starting dynamic subtest: rcs0
[339.572951] Dynamic subtest rcs0: SUCCESS (0.108s)
[339.584930] Starting dynamic subtest: vcs0
[339.649504] Dynamic subtest vcs0: SUCCESS (0.076s)
[339.662359] Starting dynamic subtest: vcs1
[339.726811] Dynamic subtest vcs1: SUCCESS (0.076s)
[339.738898] Starting dynamic subtest: vecs0
[339.803499] Dynamic subtest vecs0: SUCCESS (0.076s)
[339.815731] Starting dynamic subtest: ccs0
[339.895908] Dynamic subtest ccs0: SUCCESS (0.092s)
[339.898343] Subtest implicit-write-read: SUCCESS (0.432s)
[340.990486] [078/134] (681s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[341.098616] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[341.102719] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[341.187725] [079/134] (681s left) kms_psr (fbc-psr-dpms)
[341.277104] Starting subtest: fbc-psr-dpms
[341.279692] Starting dynamic subtest: eDP-1
[341.284161] Dynamic subtest eDP-1: SKIP (0.000s)
[341.288269] Subtest fbc-psr-dpms: SKIP (0.001s)
[341.328682] [080/134] (681s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[341.433090] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[341.437379] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[341.506134] [081/134] (681s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[341.558999] Starting subtest: etime-single-wait-for-submit-submitted
[341.666082] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.106s)
[341.718559] [082/134] (681s left) gem_mmap (bad-offset)
[341.782485] Subtest bad-offset: SKIP (0.000s)
[341.841837] [083/134] (681s left) syncobj_basic (illegal-fd-to-handle)
[341.909838] Starting subtest: illegal-fd-to-handle
[341.912060] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[341.995354] [084/134] (681s left) kms_cursor_legacy (torture-move)
[342.118671] Starting subtest: torture-move
[342.120961] Starting dynamic subtest: pipe-A
[348.023555] Dynamic subtest pipe-A: SUCCESS (5.900s)
[348.036034] Starting dynamic subtest: pipe-B
[353.941976] Dynamic subtest pipe-B: SUCCESS (5.916s)
[353.954275] Starting dynamic subtest: pipe-C
[362.057789] Dynamic subtest pipe-C: SUCCESS (8.112s)
[362.070639] Starting dynamic subtest: pipe-D
[369.270179] Dynamic subtest pipe-D: SUCCESS (7.209s)
[369.282684] Starting dynamic subtest: all-pipes
[374.931352] Dynamic subtest all-pipes: SUCCESS (5.660s)
[374.933720] Subtest torture-move: SUCCESS (32.809s)
[375.070865] [085/134] (648s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[375.184280] Starting subtest: fbc-psr2-cursor-plane-onoff
[375.186595] Starting dynamic subtest: eDP-1
[375.191031] Dynamic subtest eDP-1: SKIP (0.000s)
[375.195280] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[375.234434] [086/134] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[375.335231] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[375.339137] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[375.407943] [087/134] (647s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[375.504894] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[375.506832] Starting dynamic subtest: pipe-A-eDP-1
[376.261599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[376.270765] Starting dynamic subtest: pipe-B-eDP-1
[378.036874] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.773s)
[378.047749] Starting dynamic subtest: pipe-C-eDP-1
[379.874220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.834s)
[379.885319] Starting dynamic subtest: pipe-D-eDP-1
[381.700816] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[381.703078] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.190s)
[382.828516] [088/134] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[382.918694] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[382.922809] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[382.985967] [089/134] (640s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[383.077976] Starting subtest: modeset-transition-nonblocking-fencing
[383.079919] Starting dynamic subtest: 1x-outputs
[394.174077] Dynamic subtest 1x-outputs: SUCCESS (11.096s)
[394.176712] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.097s)
[395.016832] [090/134] (628s left) kms_color (ctm-0-25)
[395.122075] Starting subtest: ctm-0-25
[395.124203] Starting dynamic subtest: pipe-A-eDP-1
[398.560986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[398.572182] Starting dynamic subtest: pipe-B-eDP-1
[402.866059] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.301s)
[402.875996] Starting dynamic subtest: pipe-C-eDP-1
[406.940961] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.074s)
[406.951175] Starting dynamic subtest: pipe-D-eDP-1
[410.908513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.966s)
[410.910750] Subtest ctm-0-25: SUCCESS (15.785s)
[411.716156] [091/134] (611s left) gem_exec_params (batch-first)
[411.770950] Starting subtest: batch-first
[411.781558] Subtest batch-first: SUCCESS (0.010s)
[411.892494] [092/134] (611s left) gem_ppgtt (flink-and-close-vma-leak)
[411.960454] Starting subtest: flink-and-close-vma-leak
[412.001772] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[412.120522] [093/134] (611s left) core_getclient (basic)
[412.183966] Starting subtest: basic
[412.186297] Subtest basic: SUCCESS (0.000s)
[412.274824] [094/134] (611s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[412.405416] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[412.409829] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[412.528752] [095/134] (611s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[412.628051] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[412.630361] Starting dynamic subtest: pipe-A-eDP-1
[412.651846] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[412.661916] Starting dynamic subtest: pipe-B-eDP-1
[412.679122] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[412.687714] Starting dynamic subtest: pipe-C-eDP-1
[412.705367] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[412.713920] Starting dynamic subtest: pipe-D-eDP-1
[412.731936] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[412.735705] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[414.870893] [096/134] (608s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[414.970381] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[422.099226] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.132s)
[422.206543] [097/134] (601s left) kms_draw_crc (draw-method-mmap-cpu)
[422.303184] Starting subtest: draw-method-mmap-cpu
[422.305246] Starting dynamic subtest: xrgb8888-untiled
[422.546601] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[422.556167] Starting dynamic subtest: rgb565-untiled
[422.768041] Dynamic subtest rgb565-untiled: SUCCESS (0.219s)
[422.778053] Starting dynamic subtest: xrgb2101010-untiled
[422.990129] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[422.999771] Starting dynamic subtest: xbgr16161616f-untiled
[423.222992] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[423.232720] Starting dynamic subtest: xrgb8888-xtiled
[423.356867] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[423.367831] Starting dynamic subtest: rgb565-xtiled
[423.490235] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[423.500089] Starting dynamic subtest: xrgb2101010-xtiled
[423.612213] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[423.622283] Starting dynamic subtest: xbgr16161616f-xtiled
[423.745364] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[423.754605] Starting dynamic subtest: xrgb8888-4tiled
[423.878527] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[423.889863] Starting dynamic subtest: rgb565-4tiled
[424.012187] Dynamic subtest rgb565-4tiled: SUCCESS (0.132s)
[424.021630] Starting dynamic subtest: xrgb2101010-4tiled
[424.145466] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[424.156244] Starting dynamic subtest: xbgr16161616f-4tiled
[424.300859] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[424.302787] Subtest draw-method-mmap-cpu: SUCCESS (2.000s)
[424.394810] [098/134] (599s left) prime_mmap (test_refcounting)
[424.455528] Starting subtest: test_refcounting
[424.457177] Starting dynamic subtest: test_refcounting-smem
[424.485553] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[424.487590] Subtest test_refcounting: SUCCESS (0.032s)
[424.584629] [099/134] (599s left) gem_mmap_wc (copy)
[424.652691] Subtest copy: SKIP (0.000s)
[424.733204] [100/134] (599s left) gem_exec_schedule (fairslice-all)
[424.809073] Starting subtest: fairslice-all
[426.862922] Subtest fairslice-all: SUCCESS (2.055s)
[427.136561] [101/134] (596s left) gem_ctx_persistence (engines-queued)
[427.202864] Starting subtest: engines-queued
[427.205076] Starting dynamic subtest: rcs0
[427.336223] Dynamic subtest rcs0: SUCCESS (0.133s)
[427.351827] Starting dynamic subtest: bcs0
[427.378496] Dynamic subtest bcs0: SUCCESS (0.040s)
[427.388291] Starting dynamic subtest: vcs0
[428.851823] Dynamic subtest vcs0: SUCCESS (1.471s)
[428.865094] Starting dynamic subtest: vcs1
[430.898454] Dynamic subtest vcs1: SUCCESS (2.043s)
[430.910920] Starting dynamic subtest: vecs0
[432.882754] Dynamic subtest vecs0: SUCCESS (1.982s)
[432.894142] Starting dynamic subtest: ccs0
[433.065125] Dynamic subtest ccs0: SUCCESS (0.181s)
[433.067303] Subtest engines-queued: SUCCESS (5.864s)
[433.190183] [102/134] (590s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[433.303434] Starting subtest: plane-all-modeset-transition-fencing
[433.307798] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[433.353988] [103/134] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[433.454157] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[433.458105] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[433.561145] [104/134] (590s left) kms_3d (basic)
[433.627293] Starting subtest: basic
[435.648703] Subtest basic: SUCCESS (2.023s)
[436.118855] [105/134] (587s left) perf_pmu (semaphore-busy)
[436.164098] Starting subtest: semaphore-busy
[436.166441] Starting dynamic subtest: rcs0
[437.835091] Dynamic subtest rcs0: SUCCESS (1.668s)
[437.844885] Starting dynamic subtest: bcs0
[439.462738] Dynamic subtest bcs0: SUCCESS (1.625s)
[439.474598] Starting dynamic subtest: vcs0
[443.406677] Dynamic subtest vcs0: SUCCESS (3.941s)
[443.418363] Starting dynamic subtest: vcs1
[449.423984] Dynamic subtest vcs1: SUCCESS (6.013s)
[449.436119] Starting dynamic subtest: vecs0
[455.438564] Dynamic subtest vecs0: SUCCESS (6.012s)
[455.450177] Starting dynamic subtest: ccs0
[458.511141] Dynamic subtest ccs0: SUCCESS (3.070s)
[458.513638] Subtest semaphore-busy: SUCCESS (22.345s)
[458.632804] [106/134] (565s left) gem_mmap_gtt (hang)
[458.698210] Subtest hang: SKIP (0.000s)
[458.776074] [107/134] (565s left) core_getstats (basic)
[458.837500] Starting subtest: basic
[458.839472] Subtest basic: SUCCESS (0.000s)
[458.910643] [108/134] (565s left) gem_mmap_gtt (zero-extend)
[458.967722] Subtest zero-extend: SKIP (0.000s)
[459.031297] [109/134] (565s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[459.158354] Starting subtest: cursor-vs-flip-legacy
[488.443213] Subtest cursor-vs-flip-legacy: SUCCESS (29.281s)
[489.219298] [110/134] (535s left) gem_fenced_exec_thrash (no-spare-fences)
[489.287439] Subtest no-spare-fences: SKIP (0.000s)
[489.378823] [111/134] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[489.484702] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[489.489011] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.563822] [112/134] (534s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[489.636765] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[489.640691] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[489.795634] [113/134] (534s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[489.891221] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[489.895386] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[489.966087] [114/134] (534s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[490.080300] Starting subtest: y-tiled-64bpp-rotate-270
[490.084305] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[490.165012] [115/134] (534s left) syncobj_timeline (multi-wait-all-signaled)
[490.226875] Starting subtest: multi-wait-all-signaled
[490.229329] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[490.316735] [116/134] (534s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[495.331432] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[495.335807] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[496.139462] [117/134] (528s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[496.230164] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[496.234471] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[497.370436] [118/134] (527s left) gem_partial_pwrite_pread (write)
[497.431196] Subtest write: SKIP (0.000s)
[497.499982] [119/134] (527s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[497.560824] Subtest writes-after-reads: SKIP (0.000s)
[497.659522] [120/134] (527s left) gem_lmem_swapping (heavy-random)
[497.701262] Subtest heavy-random: SKIP (0.000s)
[497.745744] [121/134] (526s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[497.875133] Starting subtest: cursorB-vs-flipA-legacy
[497.879451] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[497.994801] [122/134] (526s left) syncobj_eventfd (invalid-bad-pad)
[498.050183] Starting subtest: invalid-bad-pad
[498.052044] Subtest invalid-bad-pad: SUCCESS (0.000s)
[498.145250] [123/134] (526s left) gem_wait (write-wait)
[498.205710] Starting subtest: write-wait
[498.208075] Starting dynamic subtest: all-engines
[499.335677] Dynamic subtest all-engines: SUCCESS (1.129s)
[499.352637] Starting dynamic subtest: rcs0
[500.399611] Dynamic subtest rcs0: SUCCESS (1.062s)
[500.416595] Starting dynamic subtest: bcs0
[501.460628] Dynamic subtest bcs0: SUCCESS (1.058s)
[501.477905] Starting dynamic subtest: vcs0
[502.516943] Dynamic subtest vcs0: SUCCESS (1.055s)
[502.535627] Starting dynamic subtest: vcs1
[503.571112] Dynamic subtest vcs1: SUCCESS (1.052s)
[503.589090] Starting dynamic subtest: vecs0
[504.633302] Dynamic subtest vecs0: SUCCESS (1.060s)
[504.652869] Starting dynamic subtest: ccs0
[505.690073] Dynamic subtest ccs0: SUCCESS (1.055s)
[505.692511] Subtest write-wait: SUCCESS (7.484s)
[505.866151] [124/134] (518s left) kms_cursor_edge_walk (64x64-left-edge)
[505.962067] Starting subtest: 64x64-left-edge
[505.964396] Starting dynamic subtest: pipe-A-eDP-1
[509.471609] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[509.480997] Starting dynamic subtest: pipe-D-eDP-1
[512.591719] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[512.594044] Subtest 64x64-left-edge: SUCCESS (6.629s)
[513.381439] [125/134] (511s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[513.489916] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[514.512726] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.022s)
[514.716021] [126/134] (510s left) gem_mmap_gtt (basic-read-write)
[514.777774] Subtest basic-read-write: SKIP (0.000s)
[514.867478] [127/134] (510s left) gen7_exec_parse (batch-without-end)
[514.945212] Subtest batch-without-end: SKIP (0.000s)
[515.049534] [128/134] (509s left) kms_addfb_basic (bad-pitch-256)
[515.116237] Starting subtest: bad-pitch-256
[515.118216] Subtest bad-pitch-256: SUCCESS (0.000s)
[515.256533] [129/134] (509s left) gem_exec_schedule (preempt-self)
[515.329501] Starting subtest: preempt-self
[515.331234] Starting dynamic subtest: rcs0
[515.347419] Dynamic subtest rcs0: SUCCESS (0.020s)
[515.359146] Starting dynamic subtest: bcs0
[515.383081] Dynamic subtest bcs0: SUCCESS (0.035s)
[515.403498] Starting dynamic subtest: vcs0
[515.419948] Dynamic subtest vcs0: SUCCESS (0.035s)
[515.431571] Starting dynamic subtest: vcs1
[515.446516] Dynamic subtest vcs1: SUCCESS (0.025s)
[515.455867] Starting dynamic subtest: vecs0
[515.469552] Dynamic subtest vecs0: SUCCESS (0.021s)
[515.478942] Starting dynamic subtest: ccs0
[515.490483] Dynamic subtest ccs0: SUCCESS (0.020s)
[515.492286] Subtest preempt-self: SUCCESS (0.164s)
[516.969086] [130/134] (508s left) kms_chamelium_edid (dp-edid-resolution-list)
[517.349984] Subtest dp-edid-resolution-list: SKIP (0.000s)
[518.128414] [131/134] (507s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[518.231302] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[518.233497] Starting dynamic subtest: pipe-A
[519.413257] Dynamic subtest pipe-A: SUCCESS (1.184s)
[519.424198] Starting dynamic subtest: pipe-B
[521.718045] Dynamic subtest pipe-B: SUCCESS (2.303s)
[521.729566] Starting dynamic subtest: pipe-C
[522.942187] Dynamic subtest pipe-C: SUCCESS (1.221s)
[522.956832] Starting dynamic subtest: pipe-D
[524.177704] Dynamic subtest pipe-D: SUCCESS (1.234s)
[524.180036] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.948s)
[525.361561] [132/134] (499s left) i915_query (query-regions-garbage-items)
[525.412071] Starting subtest: query-regions-garbage-items
[525.413982] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[525.494066] [133/134] (499s left) gem_pwrite (basic-exhaustion)
[525.546289] Subtest basic-exhaustion: SKIP (0.000s)
[525.609067] [134/134] (499s left) gem_create (hog-create)
[525.669698] Starting subtest: hog-create
[525.672161] Starting dynamic subtest: smem0
[558.900841] Dynamic subtest smem0: SUCCESS (33.229s)
[558.903293] Subtest hog-create: SUCCESS (33.231s)
[559.059392] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_pm_rps
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_selftest
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: perf
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: gem_pread
results: parsing output: 28/ for test: drm_read
results: parsing output: 29/ for test: i915_hangman
results: parsing output: 30/ for test: kms_prime
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: kms_content_protection
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: tools_test
results: parsing output: 36/ for test: kms_plane_cursor
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_getfb
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_pipe_b_c_ivb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_pipe_crc_basic
results: parsing output: 51/ for test: perf_pmu
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: gem_exec_capture
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_rpm
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: kms_pm_dc
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: vgem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_flip_scaled_crc
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_mmap
results: parsing output: 82/ for test: syncobj_basic
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_atomic_transition
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: gem_ppgtt
results: parsing output: 92/ for test: core_getclient
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_draw_crc
results: parsing output: 97/ for test: prime_mmap
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_3d
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: core_getstats
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_fenced_exec_thrash
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: syncobj_eventfd
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_cursor_edge_walk
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gen7_exec_parse
results: parsing output: 127/ for test: kms_addfb_basic
results: parsing output: 128/ for test: gem_exec_schedule
results: parsing output: 129/ for test: kms_chamelium_edid
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: i915_query
results: parsing output: 132/ for test: gem_pwrite
results: parsing output: 133/ for test: gem_create
Done.