[56.664870] Initializing watchdogs
[56.664920]   /dev/watchdog0
[56.679243] [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]
[56.683769] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.686046] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.688118] [001/131] (960s left) gem_exec_balancer (bonded-true-hang)
[56.945322] Starting subtest: bonded-true-hang
[56.947409] Subtest bonded-true-hang: SKIP (0.000s)
[57.053481] [002/131] (960s left) kms_lease (lease-again)
[57.138174] Starting subtest: lease-again
[57.139125] Starting dynamic subtest: pipe-A-eDP-1
[57.140749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[57.148137] Starting dynamic subtest: pipe-B-eDP-1
[57.149100] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[57.154449] Starting dynamic subtest: pipe-C-eDP-1
[57.155765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[57.161087] Starting dynamic subtest: pipe-D-eDP-1
[57.162017] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[57.162968] Subtest lease-again: SUCCESS (0.011s)
[57.270580] [003/131] (959s left) syncobj_basic (bad-fd-to-handle)
[57.320202] Starting subtest: bad-fd-to-handle
[57.321251] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[57.424844] [004/131] (959s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[57.515399] Starting subtest: psr-rgb565-draw-pwrite
[64.474953] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.962s)
[64.615021] [005/131] (952s left) gem_exec_schedule (submit-late-slice)
[64.675182] Starting subtest: submit-late-slice
[64.676126] Starting dynamic subtest: rcs0
[64.712918] Dynamic subtest rcs0: SUCCESS (0.038s)
[64.722124] Starting dynamic subtest: bcs0
[64.743406] Dynamic subtest bcs0: SUCCESS (0.030s)
[64.752751] Starting dynamic subtest: vcs0
[64.771816] Dynamic subtest vcs0: SUCCESS (0.028s)
[64.777591] Starting dynamic subtest: vcs1
[64.801208] Dynamic subtest vcs1: SUCCESS (0.029s)
[64.807318] Starting dynamic subtest: vecs0
[64.829840] Dynamic subtest vecs0: SUCCESS (0.028s)
[64.836053] Starting dynamic subtest: ccs0
[64.859437] Dynamic subtest ccs0: SUCCESS (0.029s)
[64.860480] Subtest submit-late-slice: SUCCESS (0.185s)
[66.071191] [006/131] (951s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[66.125064] Starting subtest: yf-tiled-ccs-to-y-tiled
[66.126876] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[66.318081] [007/131] (951s left) kms_fence_pin_leak
[66.489398] [008/131] (950s left) gem_flink_race (flink_name)
[66.516150] Starting subtest: flink_name
[71.917550] Subtest flink_name: SUCCESS (5.396s)
[72.171327] [009/131] (945s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[72.349183] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[72.350161] Starting dynamic subtest: pipe-A-eDP-1
[72.376086] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[72.382067] Starting dynamic subtest: pipe-B-eDP-1
[72.408662] Dynamic subtest pipe-B-eDP-1: SKIP (0.004s)
[72.414563] Starting dynamic subtest: pipe-C-eDP-1
[72.438387] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[72.444222] Starting dynamic subtest: pipe-D-eDP-1
[72.468989] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[72.470937] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.017s)
[74.513203] [010/131] (942s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[75.057741] Starting subtest: syncobj-stationary-timeline-chain-engines
[75.155429] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.100s)
[76.997429] [FACT gem_exec_fence (syncobj-stationary-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[76.999216] [011/131] (940s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[77.054706] Starting subtest: single-wait-for-submit-unsubmitted
[77.163491] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[77.233794] [012/131] (940s left) kms_big_fb (y-tiled-addfb-size-overflow)
[77.337907] Starting subtest: y-tiled-addfb-size-overflow
[77.339775] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[77.459101] [013/131] (940s left) kms_pm_dc (dc9-dpms)
[78.544917] Starting subtest: dc9-dpms
[79.977782] Subtest dc9-dpms: SUCCESS (1.433s)
[80.048819] [014/131] (937s left) gem_mmap_gtt (ptrace)
[80.106275] Subtest ptrace: SKIP (0.000s)
[80.169264] [015/131] (937s left) api_intel_allocator (simple-allocator)
[80.220134] Starting subtest: simple-allocator
[80.221105] Starting dynamic subtest: basic
[80.225461] Dynamic subtest basic: SUCCESS (0.006s)
[80.231376] Starting dynamic subtest: parallel-one
[80.418720] Dynamic subtest parallel-one: SUCCESS (0.191s)
[80.424411] Starting dynamic subtest: print
[80.425216] Dynamic subtest print: SUCCESS (0.000s)
[80.431617] Starting dynamic subtest: reuse
[80.432456] Dynamic subtest reuse: SUCCESS (0.000s)
[80.438727] Starting dynamic subtest: reserve
[80.439543] Dynamic subtest reserve: SUCCESS (0.000s)
[80.445180] Starting dynamic subtest: fork-reopen-allocator
[80.445968] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[80.446820] Subtest simple-allocator: SUCCESS (0.210s)
[80.571936] [016/131] (937s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[80.667689] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[87.363476] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.697s)
[87.520027] [017/131] (930s left) gem_userptr_blits (invalid-null-pointer)
[87.584598] Starting subtest: invalid-null-pointer
[87.585608] Subtest invalid-null-pointer: SUCCESS (0.001s)
[87.750919] [018/131] (930s left) gen9_exec_parse (bb-start-param)
[87.799929] Subtest bb-start-param: SKIP (0.000s)
[87.863276] [019/131] (929s left) prime_vgem (fence-wait)
[87.958036] Starting subtest: fence-wait
[87.959283] Starting dynamic subtest: rcs0
[89.011599] Dynamic subtest rcs0: SUCCESS (1.051s)
[89.020251] Starting dynamic subtest: bcs0
[90.081968] Dynamic subtest bcs0: SUCCESS (1.069s)
[90.090982] Starting dynamic subtest: vcs0
[91.130348] Dynamic subtest vcs0: SUCCESS (1.048s)
[91.137734] Starting dynamic subtest: vcs1
[92.174075] Dynamic subtest vcs1: SUCCESS (1.042s)
[92.182897] Starting dynamic subtest: vecs0
[93.216800] Dynamic subtest vecs0: SUCCESS (1.042s)
[93.225444] Starting dynamic subtest: ccs0
[94.260703] Dynamic subtest ccs0: SUCCESS (1.043s)
[94.262047] Subtest fence-wait: SUCCESS (6.300s)
[94.410107] [020/131] (923s left) sw_sync (timeline_closed_signaled)
[94.437331] Starting subtest: timeline_closed_signaled
[94.438403] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[94.507123] [021/131] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[94.599841] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[94.601646] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[94.723373] [022/131] (923s left) kms_mmap_write_crc (main)
[94.820577] Starting subtest: main
[94.821539] Starting dynamic subtest: pipe-A-eDP-1
[98.224604] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.402s)
[98.225673] Subtest main: SUCCESS (3.403s)
[99.089154] [023/131] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[99.181801] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[105.622763] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.442s)
[105.775238] [024/131] (912s left) kms_psr (psr-sprite-mmap-gtt)
[105.863639] Starting subtest: psr-sprite-mmap-gtt
[105.864648] Starting dynamic subtest: eDP-1
[107.316430] Dynamic subtest eDP-1: SKIP (1.450s)
[107.318771] Subtest psr-sprite-mmap-gtt: SKIP (1.451s)
[107.509699] [025/131] (910s left) kms_color (ctm-max)
[107.601342] Starting subtest: ctm-max
[107.602298] Starting dynamic subtest: pipe-A-eDP-1
[108.332934] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[108.340321] Starting dynamic subtest: pipe-B-eDP-1
[109.726092] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[109.732490] Starting dynamic subtest: pipe-C-eDP-1
[111.150732] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.422s)
[111.160024] Starting dynamic subtest: pipe-D-eDP-1
[112.546602] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[112.547461] Subtest ctm-max: SUCCESS (4.946s)
[113.352744] [026/131] (904s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[113.447302] Starting subtest: plane-downscale-factor-0-75-with-rotation
[113.448186] Starting dynamic subtest: pipe-A
[113.676391] Dynamic subtest pipe-A: SUCCESS (0.230s)
[113.684023] Starting dynamic subtest: pipe-B
[114.932089] Dynamic subtest pipe-B: SUCCESS (1.255s)
[114.938842] Starting dynamic subtest: pipe-C
[116.264170] Dynamic subtest pipe-C: SUCCESS (1.331s)
[116.272093] Starting dynamic subtest: pipe-D
[117.589991] Dynamic subtest pipe-D: SUCCESS (1.325s)
[117.591093] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.144s)
[118.766627] [027/131] (899s left) syncobj_wait (invalid-signal-one-illegal-handle)
[118.820782] Starting subtest: invalid-signal-one-illegal-handle
[118.821822] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[118.942210] [028/131] (899s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[119.043782] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[125.553398] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.510s)
[125.681206] [029/131] (892s left) gem_exec_reloc (basic-write-read-active)
[125.738528] Subtest basic-write-read-active: SKIP (0.000s)
[125.825748] [030/131] (892s left) kms_chamelium_color (degamma)
[125.918724] Subtest degamma: SKIP (0.000s)
[125.956179] [031/131] (892s left) gem_mmap_gtt (big-bo-tiledy)
[126.008437] Subtest big-bo-tiledY: SKIP (0.000s)
[126.063855] [032/131] (892s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[126.152036] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[126.153037] Starting dynamic subtest: pipe-A-eDP-1
[126.161713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[126.168883] Starting dynamic subtest: pipe-B-eDP-1
[126.177094] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[126.183152] Starting dynamic subtest: pipe-C-eDP-1
[126.191333] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[126.196979] Starting dynamic subtest: pipe-D-eDP-1
[126.205501] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[126.207125] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[128.368401] [033/131] (889s left) sysfs_heartbeat_interval (precise)
[128.423440] Starting subtest: precise
[128.424441] Starting dynamic subtest: vecs0
[135.912248] Dynamic subtest vecs0: SUCCESS (7.488s)
[135.921912] Starting dynamic subtest: ccs0
[137.110927] Dynamic subtest ccs0: SUCCESS (1.195s)
[137.119296] Starting dynamic subtest: vcs0
[144.948045] Dynamic subtest vcs0: SUCCESS (7.838s)
[144.958526] Starting dynamic subtest: bcs0
[146.140716] Dynamic subtest bcs0: SUCCESS (1.190s)
[146.149482] Starting dynamic subtest: rcs0
[148.933861] Dynamic subtest rcs0: SUCCESS (2.789s)
[148.942091] Starting dynamic subtest: vcs1
[155.957686] Dynamic subtest vcs1: SUCCESS (7.021s)
[155.958863] Subtest precise: SUCCESS (27.532s)
[156.040983] [034/131] (862s left) gem_create (create-ext-placement-each)
[156.209534] Starting subtest: create-ext-placement-each
[156.210804] Subtest create-ext-placement-each: SUCCESS (0.000s)
[156.326565] [035/131] (861s left) gem_ctx_isolation (nonpriv-switch)
[156.381987] Starting subtest: nonpriv-switch
[156.383107] Starting dynamic subtest: rcs0
[156.743086] Dynamic subtest rcs0: SUCCESS (0.360s)
[156.751706] Starting dynamic subtest: bcs0
[157.120879] Dynamic subtest bcs0: SUCCESS (0.377s)
[157.127779] Starting dynamic subtest: vcs0
[157.457761] Dynamic subtest vcs0: SUCCESS (0.336s)
[157.466098] Starting dynamic subtest: vcs1
[159.202318] Dynamic subtest vcs1: SUCCESS (1.743s)
[159.209907] Starting dynamic subtest: vecs0
[161.230271] Dynamic subtest vecs0: SUCCESS (2.027s)
[161.238880] Starting dynamic subtest: ccs0
[163.265876] Dynamic subtest ccs0: SUCCESS (2.035s)
[163.266956] Subtest nonpriv-switch: SUCCESS (6.884s)
[163.525952] [036/131] (854s left) prime_busy (before)
[163.575435] Starting subtest: before
[163.577379] Starting dynamic subtest: rcs0
[163.626727] Dynamic subtest rcs0: SUCCESS (0.049s)
[163.635061] Starting dynamic subtest: bcs0
[163.692550] Dynamic subtest bcs0: SUCCESS (0.064s)
[163.700862] Starting dynamic subtest: vcs0
[163.734052] Dynamic subtest vcs0: SUCCESS (0.042s)
[163.740910] Starting dynamic subtest: vcs1
[163.774200] Dynamic subtest vcs1: SUCCESS (0.040s)
[163.781328] Starting dynamic subtest: vecs0
[163.818334] Dynamic subtest vecs0: SUCCESS (0.043s)
[163.825865] Starting dynamic subtest: ccs0
[163.863221] Dynamic subtest ccs0: SUCCESS (0.044s)
[163.972730] Subtest before: SUCCESS (0.396s)
[164.071363] [037/131] (854s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[164.182389] Starting subtest: cursorB-vs-flipA-toggle
[164.185581] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[164.355190] [038/131] (854s left) kms_atomic (crtc-invalid-params)
[164.447136] Starting subtest: crtc-invalid-params
[164.448048] Starting dynamic subtest: pipe-A-eDP-1
[164.803809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.355s)
[164.804873] Subtest crtc-invalid-params: SUCCESS (0.356s)
[165.611090] [039/131] (852s left) prime_self_import (basic-with_fd_dup)
[165.635375] Starting subtest: basic-with_fd_dup
[165.663310] Subtest basic-with_fd_dup: SUCCESS (0.028s)
[165.781312] [040/131] (852s left) gem_busy (extended)
[165.966018] Starting subtest: extended
[165.967071] Starting dynamic subtest: rcs0
[166.064302] Dynamic subtest rcs0: SUCCESS (0.101s)
[166.074744] Starting dynamic subtest: bcs0
[166.106237] Dynamic subtest bcs0: SUCCESS (0.040s)
[166.115545] Starting dynamic subtest: vcs0
[167.895944] Dynamic subtest vcs0: SUCCESS (1.785s)
[167.905983] Starting dynamic subtest: vcs1
[169.880846] Dynamic subtest vcs1: SUCCESS (1.982s)
[169.888773] Starting dynamic subtest: vecs0
[171.863808] Dynamic subtest vecs0: SUCCESS (1.980s)
[171.872520] Starting dynamic subtest: ccs0
[171.907935] Dynamic subtest ccs0: SUCCESS (0.044s)
[171.910863] Subtest extended: SUCCESS (5.946s)
[172.173633] [041/131] (846s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[172.275121] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[178.930378] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.653s)
[179.083693] [042/131] (839s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[179.138398] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[179.198356] [043/131] (839s left) kms_psr (psr-primary-mmap-gtt)
[179.286327] Starting subtest: psr-primary-mmap-gtt
[179.287212] Starting dynamic subtest: eDP-1
[180.688831] Dynamic subtest eDP-1: SKIP (1.398s)
[180.691583] Subtest psr-primary-mmap-gtt: SKIP (1.400s)
[180.872694] [044/131] (837s left) gem_partial_pwrite_pread (write)
[180.929805] Subtest write: SKIP (0.000s)
[181.003086] [045/131] (837s left) kms_rotation_crc (cursor-rotation-180)
[181.095463] Starting subtest: cursor-rotation-180
[182.598262] Subtest cursor-rotation-180: SUCCESS (1.504s)
[183.776559] [046/131] (834s left) kms_invalid_mode (int-max-clock)
[183.867595] Starting subtest: int-max-clock
[183.868600] Starting dynamic subtest: pipe-A-eDP-1
[184.161732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[184.172955] Starting dynamic subtest: pipe-B-eDP-1
[184.174077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[184.181962] Starting dynamic subtest: pipe-C-eDP-1
[184.182896] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[184.188821] Starting dynamic subtest: pipe-D-eDP-1
[184.189756] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[184.190660] Subtest int-max-clock: SUCCESS (0.297s)
[185.024103] [047/131] (833s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[185.189694] Starting subtest: cursor-rapid-movement-64x64
[185.193094] Starting dynamic subtest: pipe-A-eDP-1
[185.726452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[185.752230] Starting dynamic subtest: pipe-D-eDP-1
[186.921408] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.176s)
[186.922488] Subtest cursor-rapid-movement-64x64: SUCCESS (1.732s)
[187.787110] [048/131] (830s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[187.879597] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[187.881360] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[188.001907] [049/131] (830s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[188.082836] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[197.403416] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.319s)
[197.558657] [050/131] (821s left) device_reset (unbind-reset-rebind)
[197.598857] Starting subtest: unbind-reset-rebind
[202.230046] Subtest unbind-reset-rebind: SUCCESS (4.626s)
[202.266132] [051/131] (816s left) i915_pm_rpm (system-suspend)
[204.083780] Starting subtest: system-suspend
[222.460795] Subtest system-suspend: SUCCESS (3.292s)
[228.866105] [052/131] (795s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[228.957524] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[228.959382] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[229.073994] [053/131] (795s left) sw_sync (sync_multi_consumer_producer)
[229.106659] Starting subtest: sync_multi_consumer_producer
[229.375351] Subtest sync_multi_consumer_producer: SUCCESS (0.268s)
[229.441771] [054/131] (795s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[229.495466] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[229.496337] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[229.611629] [055/131] (795s left) kms_setmode (basic)
[229.669554] Starting subtest: basic
[230.005210] Starting dynamic subtest: pipe-A-eDP-1
[233.450786] Dynamic subtest pipe-A-eDP-1: FAIL (3.401s)
[233.744464] Starting dynamic subtest: pipe-B-eDP-1
[237.229866] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.486s)
[237.540066] Subtest basic: FAIL (7.864s)
[238.361139] [056/131] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[238.450975] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[238.452891] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[238.576936] [057/131] (786s left) gem_lmem_swapping (heavy-multi)
[238.614441] Subtest heavy-multi: SKIP (0.000s)
[238.650205] [058/131] (786s left) kms_chamelium_frames (hdmi-crc-multiple)
[239.025393] Subtest hdmi-crc-multiple: SKIP (0.000s)
[239.840975] [059/131] (785s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[239.933324] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[239.934955] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[240.063867] [060/131] (785s left) kms_pwrite_crc
[241.605765] [061/131] (783s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[246.587058] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[246.587999] Starting dynamic subtest: pipe-A-eDP-1
[257.996051] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.406s)
[258.005197] Starting dynamic subtest: pipe-B-eDP-1
[269.438445] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.440s)
[269.439354] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.850s)
[270.311224] [062/131] (754s left) api_intel_bb (object-reloc-keep-cache)
[270.363758] Starting subtest: object-reloc-keep-cache
[270.366108] Subtest object-reloc-keep-cache: SKIP (0.003s)
[270.462383] [063/131] (754s left) gem_partial_pwrite_pread (reads-uncached)
[270.518218] Subtest reads-uncached: SKIP (0.000s)
[270.594735] [064/131] (754s left) kms_big_fb (linear-32bpp-rotate-90)
[270.695812] Starting subtest: linear-32bpp-rotate-90
[270.715681] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[270.848155] [065/131] (754s left) kms_feature_discovery (display-4x)
[270.932702] Starting subtest: display-4x
[270.934638] Subtest display-4x: SKIP (0.000s)
[271.024159] [066/131] (754s left) gem_mmap_gtt (fault-concurrent)
[271.067613] Subtest fault-concurrent: SKIP (0.000s)
[271.123081] [067/131] (754s left) i915_fb_tiling (basic-x-tiling)
[271.179730] Subtest basic-x-tiling: SKIP (0.000s)
[271.238566] [068/131] (754s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[271.331599] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[271.714772] Starting dynamic subtest: pipe-A-eDP-1
[274.478439] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.761s)
[274.844595] Starting dynamic subtest: pipe-B-eDP-1
[277.617043] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.777s)
[277.981023] Starting dynamic subtest: pipe-C-eDP-1
[280.739177] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.762s)
[281.097870] Starting dynamic subtest: pipe-D-eDP-1
[283.868274] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[283.869386] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.535s)
[285.062481] [069/131] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[285.150228] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[285.151861] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[285.252055] [070/131] (740s left) drm_read (short-buffer-nonblock)
[285.390385] Starting subtest: short-buffer-nonblock
[285.391486] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[285.555397] [071/131] (739s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[285.637338] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[285.638180] Starting dynamic subtest: pipe-A-default-mode
[285.922317] Dynamic subtest pipe-A-default-mode: SKIP (0.283s)
[285.929275] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.285s)
[286.789543] [072/131] (738s left) kms_psr (fbc-psr2-no-drrs)
[286.878596] Starting subtest: fbc-psr2-no-drrs
[286.879546] Starting dynamic subtest: eDP-1
[286.881419] Dynamic subtest eDP-1: SKIP (0.000s)
[286.883158] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[286.962044] [073/131] (738s left) perf (gen12-mi-rpc)
[287.091412] Starting subtest: gen12-mi-rpc
[287.092267] Starting dynamic subtest: rcs0
[287.109321] Dynamic subtest rcs0: SUCCESS (0.018s)
[287.110216] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[287.144280] [074/131] (738s left) kms_psr (pr-sprite-render)
[287.269943] Starting subtest: pr-sprite-render
[287.271689] Subtest pr-sprite-render: SKIP (0.000s)
[287.343926] [075/131] (738s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[287.434238] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[287.435883] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[287.553935] [076/131] (738s left) gem_exec_fence (basic-busy)
[287.718645] Starting subtest: basic-busy
[287.719728] Starting dynamic subtest: rcs0
[287.805273] Dynamic subtest rcs0: SUCCESS (0.087s)
[287.816403] Starting dynamic subtest: bcs0
[287.869216] Dynamic subtest bcs0: SUCCESS (0.062s)
[287.879988] Starting dynamic subtest: vcs0
[287.923112] Dynamic subtest vcs0: SUCCESS (0.052s)
[287.933935] Starting dynamic subtest: vcs1
[287.994536] Dynamic subtest vcs1: SUCCESS (0.069s)
[288.006343] Starting dynamic subtest: vecs0
[288.060480] Dynamic subtest vecs0: SUCCESS (0.064s)
[288.072666] Starting dynamic subtest: ccs0
[288.117661] Dynamic subtest ccs0: SUCCESS (0.054s)
[288.121192] Subtest basic-busy: SUCCESS (0.401s)
[290.090162] [077/131] (735s left) kms_plane (pixel-format)
[290.193698] Starting subtest: pixel-format
[290.221757] Starting dynamic subtest: pipe-A-plane-0
[294.877645] Dynamic subtest pipe-A-plane-0: SUCCESS (4.655s)
[294.885483] Starting dynamic subtest: pipe-A-plane-3
[297.122218] Dynamic subtest pipe-A-plane-3: SUCCESS (2.244s)
[297.129912] Starting dynamic subtest: pipe-A-plane-5
[297.333626] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[298.462260] Starting dynamic subtest: pipe-B-plane-0
[303.244454] Dynamic subtest pipe-B-plane-0: SUCCESS (4.789s)
[303.254138] Starting dynamic subtest: pipe-B-plane-3
[305.500249] Dynamic subtest pipe-B-plane-3: SUCCESS (2.255s)
[305.509811] Starting dynamic subtest: pipe-B-plane-5
[305.700238] Dynamic subtest pipe-B-plane-5: SUCCESS (0.199s)
[306.023187] Subtest pixel-format: SUCCESS (15.823s)
[306.840416] [078/131] (718s left) sw_sync (sync_merge_same)
[306.874488] Starting subtest: sync_merge_same
[306.875376] Subtest sync_merge_same: SUCCESS (0.000s)
[306.953736] [079/131] (718s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[307.051079] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[307.053462] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[307.159397] [080/131] (718s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[307.256880] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[313.979769] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.722s)
[314.111947] [081/131] (711s left) gem_exec_reloc (basic-gtt-wc-active)
[314.171393] Subtest basic-gtt-wc-active: SKIP (0.000s)
[314.261204] [082/131] (711s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[314.346262] Starting subtest: fbc-psr-sprite-mmap-cpu
[314.347050] Starting dynamic subtest: eDP-1
[314.348717] Dynamic subtest eDP-1: SKIP (0.000s)
[314.350289] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[314.426275] [083/131] (711s left) gem_ctx_persistence (legacy-engines-queued)
[314.475369] Starting subtest: legacy-engines-queued
[314.476240] Starting dynamic subtest: render
[314.537534] Dynamic subtest render: SUCCESS (0.063s)
[314.547908] Starting dynamic subtest: bsd1
[315.943407] Dynamic subtest bsd1: SUCCESS (1.402s)
[315.953898] Starting dynamic subtest: bsd2
[317.993479] Dynamic subtest bsd2: SUCCESS (2.047s)
[318.004542] Starting dynamic subtest: blt
[318.075120] Dynamic subtest blt: SUCCESS (0.080s)
[318.085714] Starting dynamic subtest: vebox
[319.974082] Dynamic subtest vebox: SUCCESS (1.893s)
[319.975724] Subtest legacy-engines-queued: SUCCESS (5.498s)
[320.058497] [084/131] (705s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[320.101223] Starting subtest: etime-multi-wait-all-available-unsubmitted
[320.211603] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s)
[320.297055] [085/131] (705s left) kms_sharpness_filter (filter-strength)
[320.396315] Starting subtest: filter-strength
[320.414645] Subtest filter-strength: SKIP (0.003s)
[320.478839] [086/131] (705s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[320.572831] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[327.625067] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.054s)
[327.745757] [087/131] (698s left) gem_eio (in-flight-immediate)
[327.987593] Starting subtest: in-flight-immediate
[336.979193] Subtest in-flight-immediate: SUCCESS (8.991s)
[337.179748] [088/131] (688s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[337.271591] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[337.272529] Starting dynamic subtest: pipe-A-eDP-1
[353.945515] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[353.953666] Starting dynamic subtest: pipe-B-eDP-1
[371.871996] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.796s)
[371.881012] Starting dynamic subtest: pipe-C-eDP-1
[389.829750] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.687s)
[389.838110] Starting dynamic subtest: pipe-D-eDP-1
[407.840999] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.631s)
[407.841967] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (9.930s)
[415.046529] [089/131] (617s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[415.157908] Starting subtest: 4-tiled-addfb-size-offset-overflow
[415.158880] Subtest 4-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[415.267130] [090/131] (616s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[415.384331] Starting subtest: short-flip-before-cursor-atomic-transitions
[416.340170] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.954s)
[417.185978] [091/131] (614s left) gem_exec_schedule (fifo)
[417.252130] Starting subtest: fifo
[417.253038] Starting dynamic subtest: rcs0
[417.347564] Dynamic subtest rcs0: SUCCESS (0.097s)
[417.359536] Starting dynamic subtest: vcs0
[417.428183] Dynamic subtest vcs0: SUCCESS (0.079s)
[417.438746] Starting dynamic subtest: vcs1
[417.504460] Dynamic subtest vcs1: SUCCESS (0.075s)
[417.514875] Starting dynamic subtest: vecs0
[417.577360] Dynamic subtest vecs0: SUCCESS (0.071s)
[417.587663] Starting dynamic subtest: ccs0
[417.655151] Dynamic subtest ccs0: SUCCESS (0.077s)
[417.656308] Subtest fifo: SUCCESS (0.404s)
[418.789349] [092/131] (613s left) syncobj_timeline (invalid-transfer-illegal-handle)
[418.838672] Starting subtest: invalid-transfer-illegal-handle
[418.839681] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[418.947934] [093/131] (613s left) kms_psr (fbc-pr-primary-blt)
[419.036439] Starting subtest: fbc-pr-primary-blt
[419.038169] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[419.113513] [094/131] (613s left) i915_drm_fdinfo (memory-info-idle)
[419.147131] Starting subtest: memory-info-idle
[419.148212] Starting dynamic subtest: smem0
[419.200151] Dynamic subtest smem0: SUCCESS (0.052s)
[419.201518] Subtest memory-info-idle: SUCCESS (0.053s)
[419.279397] [095/131] (612s left) gem_exec_reloc (basic-gtt-read-active)
[419.337418] Subtest basic-gtt-read-active: SKIP (0.000s)
[419.428647] [096/131] (612s left) kms_big_fb (yf-tiled-addfb)
[419.532273] Starting subtest: yf-tiled-addfb
[419.534199] Subtest yf-tiled-addfb: SKIP (0.000s)
[419.666521] [097/131] (612s left) i915_suspend (basic-s2idle-without-i915)
[419.693323] Starting subtest: basic-s2idle-without-i915
[439.083018] Subtest basic-s2idle-without-i915: SUCCESS (4.450s)
[444.227123] [098/131] (593s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[444.333769] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[444.335696] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.476054] [099/131] (592s left) gem_linear_blits (interruptible)
[444.825786] Starting subtest: interruptible
[448.714783] Subtest interruptible: SUCCESS (3.884s)
[448.866269] [100/131] (588s left) gem_shrink (reclaim)
[448.956000] Starting subtest: reclaim
[451.403210] Subtest reclaim: SUCCESS (2.441s)
[451.541959] [101/131] (585s left) gen7_exec_parse (basic-allocation)
[451.600273] Subtest basic-allocation: SKIP (0.000s)
[451.680852] [102/131] (585s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[451.783073] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[455.530532] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.746s)
[456.697219] [103/131] (580s left) kms_vblank (ts-continuation-modeset-hang)
[456.780192] Starting subtest: ts-continuation-modeset-hang
[456.781147] Starting dynamic subtest: pipe-A-eDP-1
[483.400182] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.612s)
[483.409811] Starting dynamic subtest: pipe-D-eDP-1
[498.376992] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.974s)
[498.378401] Subtest ts-continuation-modeset-hang: SUCCESS (41.591s)
[499.218967] [104/131] (538s left) gem_readwrite (read-write)
[499.278046] Subtest read-write: SKIP (0.000s)
[499.338151] [105/131] (538s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[504.308976] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[504.311638] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[505.161083] [106/131] (532s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[505.537709] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[506.365420] [107/131] (531s left) gem_mmap (bad-object)
[506.428950] Subtest bad-object: SKIP (0.000s)
[506.490781] [108/131] (531s left) kms_content_protection (srm)
[506.633631] Starting subtest: srm
[506.635759] Subtest srm: SKIP (0.004s)
[506.779227] [109/131] (530s left) gem_exec_schedule (pi-common)
[506.953508] Starting subtest: pi-common
[506.954881] Starting dynamic subtest: rcs0
[506.997408] Dynamic subtest rcs0: SUCCESS (0.045s)
[507.006741] Starting dynamic subtest: bcs0
[507.031472] Dynamic subtest bcs0: SUCCESS (0.033s)
[507.039287] Starting dynamic subtest: vcs0
[507.070506] Dynamic subtest vcs0: SUCCESS (0.038s)
[507.078355] Starting dynamic subtest: vcs1
[507.103241] Dynamic subtest vcs1: SUCCESS (0.032s)
[507.110878] Starting dynamic subtest: vecs0
[507.130616] Dynamic subtest vecs0: SUCCESS (0.027s)
[507.138365] Starting dynamic subtest: ccs0
[507.157168] Dynamic subtest ccs0: SUCCESS (0.026s)
[507.158029] Subtest pi-common: SUCCESS (0.206s)
[507.391890] [110/131] (530s left) gem_softpin (allocator-basic)
[507.441167] Starting subtest: allocator-basic
[507.509522] Subtest allocator-basic: SUCCESS (0.068s)
[507.663408] [111/131] (530s left) kms_flip (bo-too-big-interruptible)
[507.749279] Starting subtest: bo-too-big-interruptible
[507.751606] Starting dynamic subtest: A-eDP1
[509.035260] Dynamic subtest A-eDP1: SUCCESS (1.283s)
[509.045246] Starting dynamic subtest: B-eDP1
[510.268984] Dynamic subtest B-eDP1: SUCCESS (1.232s)
[510.277473] Starting dynamic subtest: C-eDP1
[511.515944] Dynamic subtest C-eDP1: SUCCESS (1.246s)
[511.525132] Starting dynamic subtest: D-eDP1
[512.755753] Dynamic subtest D-eDP1: SUCCESS (1.238s)
[512.759289] Subtest bo-too-big-interruptible: SUCCESS (5.008s)
[513.973862] [112/131] (523s left) gem_pread (exhaustion)
[514.027070] Subtest exhaustion: SKIP (0.000s)
[514.081230] [113/131] (523s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[514.159148] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[514.160868] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[514.275068] [114/131] (523s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[514.362476] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[514.363488] Starting dynamic subtest: pipe-A-eDP-1
[514.509869] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s)
[514.519340] Starting dynamic subtest: pipe-B-eDP-1
[514.527124] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[514.535007] Starting dynamic subtest: pipe-C-eDP-1
[514.543253] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[514.550861] Starting dynamic subtest: pipe-D-eDP-1
[514.559062] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[514.559907] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.178s)
[516.841855] [115/131] (521s left) kms_dp_link_training (non-uhbr-mst)
[516.923070] Starting subtest: non-uhbr-mst
[516.926459] Subtest non-uhbr-mst: SKIP (0.000s)
[517.002520] [116/131] (520s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[517.119787] Starting subtest: verify-pxp-execution-after-suspend-resume
[524.101194] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (6.938s)
[530.220161] [117/131] (513s left) kms_cursor_edge_walk (256x256-top-bottom)
[530.319307] Starting subtest: 256x256-top-bottom
[530.320273] Starting dynamic subtest: pipe-A-eDP-1
[533.766102] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.447s)
[533.778713] Starting dynamic subtest: pipe-D-eDP-1
[536.901284] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.134s)
[536.902144] Subtest 256x256-top-bottom: SUCCESS (6.585s)
[537.721769] [118/131] (506s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[539.735441] Starting subtest: modeset-non-lpsp-stress-no-wait
[539.797194] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.063s)
[540.138235] [119/131] (503s left) gem_exec_store (cachelines)
[540.199432] Starting subtest: cachelines
[540.200576] Starting dynamic subtest: rcs0
[540.322961] Dynamic subtest rcs0: SUCCESS (0.122s)
[540.334302] Starting dynamic subtest: bcs0
[540.393093] Dynamic subtest bcs0: SUCCESS (0.068s)
[540.404637] Starting dynamic subtest: vcs0
[540.457608] Dynamic subtest vcs0: SUCCESS (0.063s)
[540.468575] Starting dynamic subtest: vcs1
[540.521072] Dynamic subtest vcs1: SUCCESS (0.061s)
[540.530608] Starting dynamic subtest: vecs0
[540.582908] Dynamic subtest vecs0: SUCCESS (0.061s)
[540.593943] Starting dynamic subtest: ccs0
[540.645126] Dynamic subtest ccs0: SUCCESS (0.060s)
[540.646287] Subtest cachelines: SUCCESS (0.447s)
[540.835552] [120/131] (503s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[540.897276] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[540.898462] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[541.031664] [121/131] (503s left) gem_exec_flush (basic-wb-set-default)
[541.095324] Starting subtest: basic-wb-set-default
[546.546892] Subtest basic-wb-set-default: SUCCESS (5.452s)
[546.754461] [122/131] (497s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[546.858845] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[547.938757] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[548.067641] [123/131] (496s left) kms_pm_backlight (fade-with-suspend)
[548.162782] Starting subtest: fade-with-suspend
[564.747070] Starting dynamic subtest: eDP-1
[567.411528] Dynamic subtest eDP-1: SUCCESS (2.669s)
[567.412937] Subtest fade-with-suspend: SUCCESS (4.291s)
[572.261886] [124/131] (476s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[572.321105] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[572.322124] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[572.440482] [125/131] (475s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[572.545634] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[573.205076] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[573.408362] [126/131] (474s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[573.506559] Starting subtest: fbc-rgb565-draw-mmap-gtt
[573.508358] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[573.632353] [127/131] (474s left) kms_cursor_legacy (torture-bo)
[573.745940] Starting subtest: torture-bo
[573.746791] Starting dynamic subtest: pipe-A
[579.793053] Dynamic subtest pipe-A: SUCCESS (6.036s)
[579.805717] Starting dynamic subtest: pipe-B
[585.786754] Dynamic subtest pipe-B: SUCCESS (5.985s)
[585.797706] Starting dynamic subtest: pipe-C
[592.788642] Dynamic subtest pipe-C: SUCCESS (6.995s)
[592.799120] Starting dynamic subtest: pipe-D
[599.612058] Dynamic subtest pipe-D: SUCCESS (6.817s)
[599.622988] Starting dynamic subtest: all-pipes
[606.098255] Dynamic subtest all-pipes: SUCCESS (6.482s)
[606.099577] Subtest torture-bo: SUCCESS (32.326s)
[606.274992] [128/131] (442s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[606.326227] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[606.327570] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[606.455231] [129/131] (442s left) perf (gen12-group-concurrent-oa-buffer-read)
[606.586803] Starting subtest: gen12-group-concurrent-oa-buffer-read
[616.631686] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.047s)
[616.673573] [130/131] (431s left) gem_exec_async (concurrent-writes)
[616.732143] Starting subtest: concurrent-writes
[616.733069] Starting dynamic subtest: rcs0
[616.746826] Dynamic subtest rcs0: SUCCESS (0.017s)
[616.756614] Starting dynamic subtest: bcs0
[616.757552] Dynamic subtest bcs0: SUCCESS (0.005s)
[616.766849] Starting dynamic subtest: vcs0
[616.767697] Dynamic subtest vcs0: SUCCESS (0.004s)
[616.775678] Starting dynamic subtest: vcs1
[616.776845] Dynamic subtest vcs1: SUCCESS (0.006s)
[616.784649] Starting dynamic subtest: vecs0
[616.785492] Dynamic subtest vecs0: SUCCESS (0.007s)
[616.793382] Starting dynamic subtest: ccs0
[616.794215] Dynamic subtest ccs0: SUCCESS (0.008s)
[616.795072] Subtest concurrent-writes: SUCCESS (0.051s)
[617.048488] [131/131] (431s left) kms_flip (2x-flip-vs-fences-interruptible)
[617.132509] Starting subtest: 2x-flip-vs-fences-interruptible
[617.134264] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[617.244845] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_balancer
results: parsing output: 1/ for test: kms_lease
results: parsing output: 2/ for test: syncobj_basic
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_render_copy
results: parsing output: 6/ for test: kms_fence_pin_leak
results: parsing output: 7/ for test: gem_flink_race
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: gem_mmap_gtt
results: parsing output: 14/ for test: api_intel_allocator
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: sw_sync
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_mmap_write_crc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: gem_mmap_gtt
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: sysfs_heartbeat_interval
results: parsing output: 33/ for test: gem_create
results: parsing output: 34/ for test: gem_ctx_isolation
results: parsing output: 35/ for test: prime_busy
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_atomic
results: parsing output: 38/ for test: prime_self_import
results: parsing output: 39/ for test: gem_busy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_cursor_crc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: device_reset
results: parsing output: 50/ for test: i915_pm_rpm
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_setmode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_chamelium_frames
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_pwrite_crc
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: gem_partial_pwrite_pread
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_feature_discovery
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: i915_fb_tiling
results: parsing output: 67/ for test: kms_async_flips
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: drm_read
results: parsing output: 70/ for test: kms_flip_scaled_crc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_exec_fence
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_sharpness_filter
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_eio
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: gem_exec_schedule
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: i915_suspend
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_linear_blits
results: parsing output: 99/ for test: gem_shrink
results: parsing output: 100/ for test: gen7_exec_parse
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: gem_readwrite
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: gem_softpin
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_dp_link_training
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_cursor_edge_walk
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_exec_store
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_pm_backlight
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: gem_exec_async
results: parsing output: 130/ for test: kms_flip
Done.