[56.980550] Initializing watchdogs
[56.980634]   /dev/watchdog0
[56.994628] [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.998596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.000658] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.003900] [001/130] (960s left) gem_exec_schedule (preempt-queue-contexts-chain)
[57.145359] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[57.441963] [002/130] (960s left) kms_cursor_legacy (single-bo)
[57.567029] Starting subtest: single-bo
[57.569263] Starting dynamic subtest: pipe-A
[62.977580] Dynamic subtest pipe-A: SUCCESS (5.382s)
[62.984924] Starting dynamic subtest: pipe-B
[68.373916] Dynamic subtest pipe-B: SUCCESS (5.383s)
[68.383287] Starting dynamic subtest: pipe-C
[73.761577] Dynamic subtest pipe-C: SUCCESS (5.382s)
[73.768508] Starting dynamic subtest: pipe-D
[79.149096] Dynamic subtest pipe-D: SUCCESS (5.383s)
[79.157032] Starting dynamic subtest: all-pipes
[84.539082] Dynamic subtest all-pipes: SUCCESS (5.389s)
[84.541234] Subtest single-bo: SUCCESS (26.922s)
[84.661956] [003/130] (932s left) syncobj_wait (multi-wait-submitted)
[84.722933] Starting subtest: multi-wait-submitted
[84.830473] Subtest multi-wait-submitted: SUCCESS (0.107s)
[84.893459] [004/130] (932s left) gem_exec_params (larger-than-life-batch)
[84.952232] Starting subtest: larger-than-life-batch
[88.479073] Subtest larger-than-life-batch: SUCCESS (3.525s)
[88.980503] [005/130] (928s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[89.131149] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[89.133499] Starting dynamic subtest: pipe-A-default-mode
[89.420446] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[89.425440] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.285s)
[90.275141] [006/130] (927s left) drm_read (fault-buffer)
[90.472380] Starting subtest: fault-buffer
[90.475067] Subtest fault-buffer: SUCCESS (0.000s)
[90.596197] [007/130] (927s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[90.697249] Starting subtest: psr-rgb565-draw-mmap-cpu
[95.371109] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.675s)
[95.475905] [008/130] (922s left) syncobj_timeline (etime-multi-wait-all-submitted)
[95.535031] Starting subtest: etime-multi-wait-all-submitted
[95.636429] Subtest etime-multi-wait-all-submitted: SUCCESS (0.101s)
[95.705932] [009/130] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[95.807271] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[98.750247] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.946s)
[98.938589] [010/130] (918s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[99.047938] Starting subtest: y-tiled-32bpp-rotate-0
[99.051755] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[99.144980] [011/130] (918s left) kms_writeback (writeback-invalid-parameters)
[99.247536] Subtest writeback-invalid-parameters: SKIP (0.000s)
[99.285940] [012/130] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[99.394388] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[104.959904] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.566s)
[105.051914] [013/130] (912s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[105.155037] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[105.157289] Starting dynamic subtest: pipe-A-default-mode
[105.469938] Dynamic subtest pipe-A-default-mode: SKIP (0.312s)
[105.474281] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.313s)
[106.300339] [014/130] (911s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[106.400862] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[106.403152] Starting dynamic subtest: pipe-A
[106.904254] Dynamic subtest pipe-A: SUCCESS (0.503s)
[106.913192] Starting dynamic subtest: pipe-B
[108.470176] Dynamic subtest pipe-B: SUCCESS (1.566s)
[108.477572] Starting dynamic subtest: pipe-C
[110.090370] Dynamic subtest pipe-C: SUCCESS (1.620s)
[110.099540] Starting dynamic subtest: pipe-D
[111.715459] Dynamic subtest pipe-D: SUCCESS (1.625s)
[111.717833] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (5.314s)
[112.909362] [015/130] (905s left) syncobj_basic (bad-pad-fd-to-handle)
[112.972209] Starting subtest: bad-pad-fd-to-handle
[112.974568] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[113.077641] [016/130] (904s left) kms_draw_crc (draw-method-blt)
[113.176937] Starting subtest: draw-method-blt
[113.178902] Starting dynamic subtest: xrgb8888-untiled
[113.404825] Dynamic subtest xrgb8888-untiled: SUCCESS (0.230s)
[113.412164] Starting dynamic subtest: rgb565-untiled
[113.604507] Dynamic subtest rgb565-untiled: SUCCESS (0.200s)
[113.612266] Starting dynamic subtest: xrgb2101010-untiled
[113.815604] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[113.823077] Starting dynamic subtest: xbgr16161616f-untiled
[114.038168] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[114.045408] Starting dynamic subtest: xrgb8888-xtiled
[114.137404] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.100s)
[114.148388] Starting dynamic subtest: rgb565-xtiled
[114.237594] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s)
[114.245411] Starting dynamic subtest: xrgb2101010-xtiled
[114.326392] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.089s)
[114.334355] Starting dynamic subtest: xbgr16161616f-xtiled
[114.437840] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[114.445353] Starting dynamic subtest: xrgb8888-4tiled
[114.548907] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.111s)
[114.556949] Starting dynamic subtest: rgb565-4tiled
[114.659754] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[114.667407] Starting dynamic subtest: xrgb2101010-4tiled
[114.748776] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.088s)
[114.755900] Starting dynamic subtest: xbgr16161616f-4tiled
[114.859991] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[114.862063] Subtest draw-method-blt: SUCCESS (1.686s)
[114.955775] [017/130] (903s left) gem_exec_params (cliprects-invalid)
[115.018151] Starting subtest: cliprects-invalid
[115.020133] Subtest cliprects-invalid: SUCCESS (0.000s)
[115.120152] [018/130] (902s left) perf (enable-disable)
[115.232322] Starting subtest: enable-disable
[115.234316] Starting dynamic subtest: 0-rcs0
[117.518295] Dynamic subtest 0-rcs0: SUCCESS (2.287s)
[117.525421] Starting dynamic subtest: 1-vcs1
[122.021443] Dynamic subtest 1-vcs1: SUCCESS (4.502s)
[122.024064] Subtest enable-disable: SUCCESS (6.789s)
[122.061877] [019/130] (896s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[122.459232] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[123.212084] [020/130] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[123.319681] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[123.324061] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[123.426619] [021/130] (894s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[123.528117] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[123.530497] Starting dynamic subtest: pipe-A-eDP-1
[123.555137] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[123.567418] Starting dynamic subtest: pipe-B-eDP-1
[123.589933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[123.598589] Starting dynamic subtest: pipe-C-eDP-1
[123.620253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[123.627211] Starting dynamic subtest: pipe-D-eDP-1
[123.649700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[123.654656] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[125.684988] [022/130] (892s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[125.778572] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[125.783116] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[125.871816] [023/130] (892s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[125.968970] Starting subtest: primary-y-tiled-reflect-x-270
[125.973536] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[126.035476] [024/130] (892s left) gem_exec_nop (basic-parallel)
[126.113626] Starting subtest: basic-parallel
[141.866967] Subtest basic-parallel: SUCCESS (15.761s)
[142.093970] [025/130] (876s left) testdisplay
[142.443293] [026/130] (875s left) gem_ctx_persistence (hostile)
[142.512887] Starting subtest: hostile
[152.033084] Subtest hostile: SUCCESS (9.515s)
[152.167830] [027/130] (866s left) api_intel_bb (simple-bb-ctx)
[152.230358] Starting subtest: simple-bb-ctx
[152.241141] Subtest simple-bb-ctx: SUCCESS (0.013s)
[152.368677] [028/130] (866s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[152.477396] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[152.481994] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[152.552838] [029/130] (865s left) kms_big_fb (linear-32bpp-rotate-0)
[152.656402] Starting subtest: linear-32bpp-rotate-0
[154.510319] Subtest linear-32bpp-rotate-0: SUCCESS (1.855s)
[154.682717] [030/130] (863s left) kms_flip (flip-vs-expired-vblank)
[154.776263] Starting subtest: flip-vs-expired-vblank
[154.778183] Starting dynamic subtest: A-eDP1
[163.495515] Dynamic subtest A-eDP1: SUCCESS (8.718s)
[163.504496] Starting dynamic subtest: B-eDP1
[172.222841] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[172.231395] Starting dynamic subtest: C-eDP1
[180.931695] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[180.941242] Starting dynamic subtest: D-eDP1
[189.658155] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[189.663523] Subtest flip-vs-expired-vblank: SUCCESS (34.887s)
[190.818468] [031/130] (827s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[190.935927] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[190.938390] Starting dynamic subtest: pipe-A-eDP-1
[190.963060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.972347] Starting dynamic subtest: pipe-B-eDP-1
[190.994961] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[191.002510] Starting dynamic subtest: pipe-C-eDP-1
[191.024938] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[191.032950] Starting dynamic subtest: pipe-D-eDP-1
[191.056677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[191.060972] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[193.080150] [032/130] (825s left) kms_feature_discovery (psr2)
[193.177869] Starting subtest: psr2
[193.179802] Subtest psr2: SUCCESS (0.000s)
[193.241707] [033/130] (825s left) gem_mmap_offset (mmap-unmap)
[193.304484] Starting subtest: mmap-unmap
[193.306757] Starting dynamic subtest: smem0
[217.898465] Dynamic subtest smem0: SUCCESS (24.595s)
[217.901096] Subtest mmap-unmap: SUCCESS (24.595s)
[218.056774] [034/130] (800s left) kms_hdmi_inject (inject-4k)
[218.405667] Starting subtest: inject-4k
[218.714192] Subtest inject-4k: SUCCESS (0.309s)
[219.228733] [035/130] (799s left) vgem_basic (create)
[219.324041] Starting subtest: create
[219.325876] Subtest create: SUCCESS (0.000s)
[219.372064] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[219.375122] [036/130] (799s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[219.472280] Starting subtest: fbc-psr2-primary-mmap-cpu
[219.474491] Starting dynamic subtest: eDP-1
[219.478537] Dynamic subtest eDP-1: SKIP (0.000s)
[219.482753] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[219.538589] [037/130] (799s left) gem_mmap_gtt (cpuset-big-copy-odd)
[219.595725] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[219.656775] [038/130] (799s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[219.760829] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[219.765321] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[219.870361] [039/130] (798s left) gem_bad_reloc (negative-reloc)
[219.929292] Subtest negative-reloc: SKIP (0.000s)
[220.003509] [040/130] (798s left) kms_chamelium_edid (vga-edid-read)
[220.392829] Subtest vga-edid-read: SKIP (0.000s)
[221.176519] [041/130] (797s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[221.277552] Starting subtest: 4-tiled-8bpp-rotate-90
[221.297288] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.019s)
[221.393828] [042/130] (797s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[223.137367] Starting subtest: gem-execbuf-stress-pc8
[223.186330] Subtest gem-execbuf-stress-pc8: SKIP (0.047s)
[223.699392] [043/130] (795s left) kms_psr (pr-primary-mmap-gtt)
[223.802133] Starting subtest: pr-primary-mmap-gtt
[223.806234] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[223.866805] [044/130] (795s left) gem_exec_basic (basic)
[223.920658] Starting subtest: basic
[223.922890] Starting dynamic subtest: rcs0-smem
[223.925073] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[223.933586] Starting dynamic subtest: bcs0-smem
[223.935852] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[223.942911] Starting dynamic subtest: vcs0-smem
[223.945087] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[223.952250] Starting dynamic subtest: vcs1-smem
[223.954336] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[223.961220] Starting dynamic subtest: vecs0-smem
[223.963299] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[223.970265] Starting dynamic subtest: ccs0-smem
[223.972410] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[223.974577] Subtest basic: SUCCESS (0.012s)
[226.006340] [045/130] (793s left) gem_spin_batch (legacy)
[226.070561] Starting subtest: legacy
[226.072951] Starting dynamic subtest: default
[229.312772] Dynamic subtest default: SUCCESS (3.237s)
[229.321227] Starting dynamic subtest: render
[232.547850] Dynamic subtest render: SUCCESS (3.233s)
[232.555929] Starting dynamic subtest: bsd
[235.784852] Dynamic subtest bsd: SUCCESS (3.236s)
[235.794803] Starting dynamic subtest: bsd1
[239.020219] Dynamic subtest bsd1: SUCCESS (3.234s)
[239.027952] Starting dynamic subtest: bsd2
[242.256640] Dynamic subtest bsd2: SUCCESS (3.235s)
[242.264949] Starting dynamic subtest: blt
[245.495872] Dynamic subtest blt: SUCCESS (3.237s)
[245.504055] Starting dynamic subtest: vebox
[248.729563] Dynamic subtest vebox: SUCCESS (3.232s)
[248.731680] Subtest legacy: SUCCESS (22.654s)
[249.024350] [046/130] (770s left) kms_content_protection (srm)
[249.210472] Starting subtest: srm
[252.553327] Subtest srm: SKIP (3.341s)
[253.799070] [047/130] (765s left) gem_exec_reloc (basic-cpu-wc-active)
[253.859625] Subtest basic-cpu-wc-active: SKIP (0.000s)
[253.926129] [048/130] (765s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[254.026738] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[254.031066] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[254.128372] [049/130] (765s left) kms_plane_multiple (tiling-y)
[254.216168] Starting subtest: tiling-y
[254.220847] Subtest tiling-y: SKIP (0.000s)
[254.283033] [050/130] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[254.394126] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[254.398305] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[254.479413] [051/130] (764s left) kms_rotation_crc (bad-pixel-format)
[254.576075] Starting subtest: bad-pixel-format
[254.580673] Subtest bad-pixel-format: SKIP (0.001s)
[254.648314] [052/130] (764s left) prime_self_import (basic-with_one_bo)
[254.683050] Starting subtest: basic-with_one_bo
[254.701574] Subtest basic-with_one_bo: SUCCESS (0.018s)
[254.799900] [053/130] (764s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[255.188742] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[255.974993] [054/130] (763s left) syncobj_wait (wait-all-complex)
[256.030497] Starting subtest: wait-all-complex
[256.244605] Subtest wait-all-complex: SUCCESS (0.214s)
[256.316785] [055/130] (763s left) gem_exec_reloc (basic-softpin)
[256.378474] Subtest basic-softpin: SKIP (0.000s)
[256.433293] [056/130] (762s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[256.494784] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[256.500026] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[256.670898] [057/130] (762s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[256.763125] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[256.765501] Starting dynamic subtest: pipe-A-eDP-1
[256.789246] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[256.798139] Starting dynamic subtest: pipe-B-eDP-1
[256.820139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[256.827440] Starting dynamic subtest: pipe-C-eDP-1
[256.848950] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[256.856047] Starting dynamic subtest: pipe-D-eDP-1
[256.878147] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[256.883257] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.003s)
[258.994595] [058/130] (760s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[259.058462] Starting subtest: etime-single-wait-for-submit-submitted
[259.165862] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[259.237358] [059/130] (760s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[259.341855] Starting subtest: fbc-rgb565-draw-mmap-wc
[262.376551] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.039s)
[262.496669] [060/130] (757s left) gem_exec_params (dr1-dirt)
[262.553466] Starting subtest: DR1-dirt
[262.555479] Subtest DR1-dirt: SUCCESS (0.000s)
[262.661077] [061/130] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[262.760040] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[267.337200] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.579s)
[267.453949] [062/130] (752s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[267.568427] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[267.572754] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[267.685519] [063/130] (751s left) kms_cursor_crc (cursor-random-512x512)
[267.914470] Starting subtest: cursor-random-512x512
[267.918693] Subtest cursor-random-512x512: SKIP (0.001s)
[268.079027] [064/130] (751s left) i915_pm_rc6_residency (rc6-idle)
[268.145443] Starting subtest: rc6-idle
[268.167751] Starting dynamic subtest: gt0-rcs0
[280.391104] Dynamic subtest gt0-rcs0: SUCCESS (12.222s)
[280.399120] Starting dynamic subtest: gt0-bcs0
[292.649295] Dynamic subtest gt0-bcs0: SUCCESS (12.255s)
[292.659520] Starting dynamic subtest: gt0-ccs0
[304.904390] Dynamic subtest gt0-ccs0: SUCCESS (12.253s)
[304.917992] Starting dynamic subtest: gt1-vcs0
[317.122417] Dynamic subtest gt1-vcs0: SUCCESS (12.214s)
[317.131728] Starting dynamic subtest: gt1-vecs0
[330.073521] Dynamic subtest gt1-vecs0: SUCCESS (12.948s)
[330.076017] Subtest rc6-idle: SUCCESS (61.924s)
[330.890752] [065/130] (688s left) kms_pm_rpm (modeset-pc8-residency-stress)
[333.050079] Starting subtest: modeset-pc8-residency-stress
[333.055115] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[333.414158] [066/130] (686s left) gem_exec_flush (basic-uc-pro-default)
[333.476520] Starting subtest: basic-uc-pro-default
[338.967185] Subtest basic-uc-pro-default: SUCCESS (5.491s)
[339.156072] [067/130] (680s left) gem_exec_reloc (basic-range)
[339.229844] Subtest basic-range: SKIP (0.000s)
[339.289341] [068/130] (680s left) kms_flip (basic-flip-vs-modeset)
[339.384074] Starting subtest: basic-flip-vs-modeset
[339.386246] Starting dynamic subtest: A-eDP1
[341.923314] Dynamic subtest A-eDP1: SUCCESS (2.536s)
[341.934701] Starting dynamic subtest: B-eDP1
[344.117134] Dynamic subtest B-eDP1: SUCCESS (2.195s)
[344.127643] Starting dynamic subtest: C-eDP1
[346.321196] Dynamic subtest C-eDP1: SUCCESS (2.202s)
[346.332091] Starting dynamic subtest: D-eDP1
[348.515632] Dynamic subtest D-eDP1: SUCCESS (2.195s)
[348.518237] Subtest basic-flip-vs-modeset: SUCCESS (9.134s)
[349.388767] [069/130] (670s left) kms_cursor_crc (cursor-random-max-size)
[349.670686] Starting subtest: cursor-random-max-size
[349.677474] Subtest cursor-random-max-size: SKIP (0.000s)
[349.805884] [070/130] (670s left) gem_pxp (create-protected-buffer)
[349.925906] Starting subtest: create-protected-buffer
[349.928616] Subtest create-protected-buffer: SUCCESS (0.000s)
[350.027679] [071/130] (669s left) perf_pmu (busy-idle-check-all)
[350.069622] Starting subtest: busy-idle-check-all
[350.071525] Starting dynamic subtest: rcs0
[350.745072] Dynamic subtest rcs0: SUCCESS (0.676s)
[350.755699] Starting dynamic subtest: bcs0
[351.398422] Dynamic subtest bcs0: SUCCESS (0.652s)
[351.409786] Starting dynamic subtest: vcs0
[352.937479] Dynamic subtest vcs0: SUCCESS (1.536s)
[352.948956] Starting dynamic subtest: vcs1
[354.921797] Dynamic subtest vcs1: SUCCESS (1.982s)
[354.932621] Starting dynamic subtest: vecs0
[356.905596] Dynamic subtest vecs0: SUCCESS (1.982s)
[356.916479] Starting dynamic subtest: ccs0
[357.563649] Dynamic subtest ccs0: SUCCESS (0.657s)
[357.566216] Subtest busy-idle-check-all: SUCCESS (7.495s)
[357.678135] [072/130] (662s left) kms_getfb (getfb2-handle-protection)
[357.739456] Starting subtest: getfb2-handle-protection
[357.763966] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[357.895101] [073/130] (662s left) sw_sync (sync_multi_timeline_wait)
[357.933897] Starting subtest: sync_multi_timeline_wait
[357.936123] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[357.982383] [074/130] (662s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[358.090150] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[358.094292] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[358.208930] [075/130] (661s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[358.317705] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[358.321842] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[358.422708] [076/130] (661s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[358.548348] Starting subtest: basic-busy-flip-before-cursor-legacy
[358.551902] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[358.677777] [077/130] (661s left) kms_selftest (drm_plane_helper)
[358.720084] Starting subtest: drm_plane_helper
[358.734304] Starting dynamic subtest: drm_test_check_plane_state
[358.893964] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.157s)
[358.903081] Starting dynamic subtest: drm_test_check_invalid_plane_state
[359.035584] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.143s)
[359.038094] Subtest drm_plane_helper: SUCCESS (0.315s)
[359.214986] [078/130] (660s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[359.276811] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[359.279266] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[359.383834] [079/130] (660s left) kms_rotation_crc (primary-rotation-270)
[359.478069] Starting subtest: primary-rotation-270
[359.482547] Subtest primary-rotation-270: SKIP (0.001s)
[359.547613] [080/130] (660s left) gem_mmap (basic-small-bo)
[359.613069] Subtest basic-small-bo: SKIP (0.000s)
[359.663791] [081/130] (660s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[359.721925] Starting subtest: legacy-engines-hostile-preempt
[359.724381] Starting dynamic subtest: render
[359.801686] Dynamic subtest render: SUCCESS (0.079s)
[359.812239] Starting dynamic subtest: bsd1
[360.918398] Dynamic subtest bsd1: SUCCESS (1.113s)
[360.929517] Starting dynamic subtest: bsd2
[362.949799] Dynamic subtest bsd2: SUCCESS (2.028s)
[362.960756] Starting dynamic subtest: blt
[363.018588] Dynamic subtest blt: SUCCESS (0.069s)
[363.029050] Starting dynamic subtest: vebox
[364.928394] Dynamic subtest vebox: SUCCESS (1.906s)
[364.931042] Subtest legacy-engines-hostile-preempt: SUCCESS (5.206s)
[365.000516] [082/130] (655s left) gem_exec_balancer (hog)
[365.065290] Starting subtest: hog
[365.069735] Subtest hog: SKIP (0.000s)
[365.370935] [083/130] (654s left) gem_exec_whisper (basic-fds-priority)
[365.446958] Starting subtest: basic-fds-priority
[389.349429] Subtest basic-fds-priority: SUCCESS (23.898s)
[389.526549] [084/130] (630s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[389.587557] Starting subtest: single-wait-for-submit-available-submitted
[389.589727] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[389.695183] [085/130] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[389.810423] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[389.814518] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[389.900352] [086/130] (630s left) kms_big_fb (y-tiled-addfb)
[390.001178] Starting subtest: y-tiled-addfb
[390.005242] Subtest y-tiled-addfb: SKIP (0.000s)
[390.110350] [087/130] (630s left) dmabuf_sync_file (import-multiple-read-only)
[390.153355] Starting subtest: import-multiple-read-only
[390.155770] Subtest import-multiple-read-only: SUCCESS (0.003s)
[390.204766] [088/130] (630s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[390.297848] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[390.302370] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[391.385513] [089/130] (629s left) kms_psr (psr2-sprite-mmap-gtt)
[391.487380] Starting subtest: psr2-sprite-mmap-gtt
[391.489756] Starting dynamic subtest: eDP-1
[392.967188] Dynamic subtest eDP-1: SKIP (1.474s)
[392.971840] Subtest psr2-sprite-mmap-gtt: SKIP (1.476s)
[393.128454] [090/130] (627s left) kms_psr (fbc-pr-primary-mmap-gtt)
[393.229392] Starting subtest: fbc-pr-primary-mmap-gtt
[393.233459] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[393.294607] [091/130] (627s left) gem_bad_reloc (negative-reloc-bltcopy)
[393.353425] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[393.441098] [092/130] (627s left) fbdev (info)
[393.480071] Starting subtest: info
[393.482498] Subtest info: SUCCESS (0.000s)
[393.533960] [093/130] (627s left) perf (blocking)
[393.615915] Starting subtest: blocking
[393.618309] Starting dynamic subtest: 0-rcs0
[403.643706] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[403.652421] Starting dynamic subtest: 1-vcs0
[413.665122] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[413.667800] Subtest blocking: SUCCESS (20.047s)
[413.709905] [094/130] (607s left) gem_softpin (evict-snoop)
[413.776485] Starting subtest: evict-snoop
[413.781186] Subtest evict-snoop: SKIP (0.000s)
[413.886049] [095/130] (606s left) i915_hangman (detector)
[413.956656] Starting subtest: detector
[413.959268] Starting dynamic subtest: rcs0
[425.864247] Dynamic subtest rcs0: SUCCESS (11.905s)
[425.876077] Starting dynamic subtest: bcs0
[437.832657] Dynamic subtest bcs0: SUCCESS (11.964s)
[437.846784] Starting dynamic subtest: vcs0
[447.816094] Dynamic subtest vcs0: SUCCESS (9.981s)
[447.827740] Starting dynamic subtest: vcs1
[457.866297] Dynamic subtest vcs1: SUCCESS (10.047s)
[457.876811] Starting dynamic subtest: vecs0
[469.832402] Dynamic subtest vecs0: SUCCESS (11.964s)
[469.844810] Starting dynamic subtest: ccs0
[480.904908] Dynamic subtest ccs0: SUCCESS (11.069s)
[480.907902] Subtest detector: SUCCESS (66.945s)
[481.050719] [096/130] (539s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[481.162587] Starting subtest: x-tiled-32bpp-rotate-90
[481.181902] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[481.314364] [097/130] (539s left) vgem_basic (bad-handle)
[481.359710] Starting subtest: bad-handle
[481.362064] Subtest bad-handle: SUCCESS (0.000s)
[481.411590] [098/130] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[481.526827] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[481.531141] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[481.622697] [099/130] (539s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[483.159110] Starting subtest: dpms-mode-unset-non-lpsp
[484.330110] Subtest dpms-mode-unset-non-lpsp: SKIP (1.169s)
[484.674395] [100/130] (536s left) kms_vblank (ts-continuation-suspend)
[484.776121] Starting subtest: ts-continuation-suspend
[484.778413] Starting dynamic subtest: pipe-A-eDP-1
[501.141463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.548s)
[501.160134] Starting dynamic subtest: pipe-D-eDP-1
[518.102067] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.080s)
[518.104809] Subtest ts-continuation-suspend: SUCCESS (3.632s)
[518.959550] [101/130] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[519.066502] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[519.068997] Starting dynamic subtest: pipe-A-eDP-1
[520.401574] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.318s)
[520.412054] Starting dynamic subtest: pipe-B-eDP-1
[522.779636] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.346s)
[522.789487] Starting dynamic subtest: pipe-C-eDP-1
[525.172669] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.374s)
[525.182722] Starting dynamic subtest: pipe-D-eDP-1
[527.500203] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.311s)
[527.502808] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.353s)
[528.650586] [102/130] (522s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[528.755555] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[529.972929] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.213s)
[530.204895] [103/130] (520s left) gem_exec_fence (syncobj-timeline-wait)
[530.796208] Starting subtest: syncobj-timeline-wait
[532.551909] Subtest syncobj-timeline-wait: SUCCESS (1.753s)
[532.781735] [104/130] (518s left) gem_pread (snoop)
[532.849694] Subtest snoop: SKIP (0.000s)
[532.913549] [105/130] (518s left) kms_pipe_crc_basic (read-crc)
[533.018659] Starting subtest: read-crc
[533.021487] Starting dynamic subtest: pipe-A-eDP-1
[533.740440] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.715s)
[533.751060] Starting dynamic subtest: pipe-B-eDP-1
[535.101781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.357s)
[535.112622] Starting dynamic subtest: pipe-C-eDP-1
[536.469313] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[536.479664] Starting dynamic subtest: pipe-D-eDP-1
[537.763248] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[537.766146] Subtest read-crc: SUCCESS (4.731s)
[538.579345] [106/130] (512s left) syncobj_eventfd (invalid-illegal-handle)
[538.631652] Starting subtest: invalid-illegal-handle
[538.634582] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[538.718165] [107/130] (512s left) kms_invalid_mode (clock-too-high)
[538.811505] Starting subtest: clock-too-high
[538.813904] Starting dynamic subtest: pipe-A-eDP-1
[538.818742] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[538.828663] Starting dynamic subtest: pipe-B-eDP-1
[538.833432] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[538.842872] Starting dynamic subtest: pipe-C-eDP-1
[538.847601] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[538.856886] Starting dynamic subtest: pipe-D-eDP-1
[538.861541] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[538.865974] Subtest clock-too-high: SKIP (0.004s)
[538.898028] [108/130] (512s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[538.957664] Starting subtest: invalid-single-wait-unsubmitted
[538.960449] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[539.065625] [109/130] (512s left) kms_lease (lease-get)
[539.166724] Starting subtest: lease-get
[539.169352] Starting dynamic subtest: pipe-A-eDP-1
[539.171762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[539.181508] Starting dynamic subtest: pipe-B-eDP-1
[539.183895] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[539.193414] Starting dynamic subtest: pipe-C-eDP-1
[539.195912] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[539.205847] Starting dynamic subtest: pipe-D-eDP-1
[539.208837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[539.211656] Subtest lease-get: SUCCESS (0.009s)
[539.273360] [110/130] (511s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[539.328260] Starting subtest: yf-tiled-ccs-to-y-tiled
[539.333168] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[539.507153] [111/130] (511s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[544.567126] Starting subtest: pr-overlay-plane-move-continuous-sf
[544.572726] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[545.383152] [112/130] (505s left) gem_linear_blits (basic)
[545.649065] Starting subtest: basic
[545.659860] Subtest basic: SUCCESS (0.011s)
[545.799413] [113/130] (505s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[545.960988] Starting subtest: yf-tiled-addfb-size-overflow
[545.965684] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[546.066923] [114/130] (505s left) kms_flip (dpms-vs-vblank-race-interruptible)
[546.166627] Starting subtest: dpms-vs-vblank-race-interruptible
[546.168905] Starting dynamic subtest: A-eDP1
[550.059561] Dynamic subtest A-eDP1: SUCCESS (3.887s)
[550.071519] Starting dynamic subtest: B-eDP1
[553.548509] Dynamic subtest B-eDP1: SUCCESS (3.490s)
[553.558560] Starting dynamic subtest: C-eDP1
[557.036665] Dynamic subtest C-eDP1: SUCCESS (3.487s)
[557.047350] Starting dynamic subtest: D-eDP1
[560.545423] Dynamic subtest D-eDP1: SUCCESS (3.507s)
[560.547397] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.378s)
[561.385598] [115/130] (489s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[566.456809] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[566.459337] Starting dynamic subtest: pipe-A-eDP-1
[567.237650] Dynamic subtest pipe-A-eDP-1: SKIP (0.776s)
[567.250642] Starting dynamic subtest: pipe-B-eDP-1
[568.437445] Dynamic subtest pipe-B-eDP-1: SKIP (1.199s)
[568.441872] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.979s)
[569.582854] [116/130] (481s left) gem_ctx_isolation (dirty-create)
[569.658880] Starting subtest: dirty-create
[569.661705] Starting dynamic subtest: rcs0
[570.096852] Dynamic subtest rcs0: SUCCESS (0.437s)
[570.109012] Starting dynamic subtest: bcs0
[570.534793] Dynamic subtest bcs0: SUCCESS (0.438s)
[570.546709] Starting dynamic subtest: vcs0
[571.017476] Dynamic subtest vcs0: SUCCESS (0.482s)
[571.028386] Starting dynamic subtest: vcs1
[573.085795] Dynamic subtest vcs1: SUCCESS (2.067s)
[573.098625] Starting dynamic subtest: vecs0
[575.102876] Dynamic subtest vecs0: SUCCESS (2.016s)
[575.115557] Starting dynamic subtest: ccs0
[577.051897] Dynamic subtest ccs0: SUCCESS (1.948s)
[577.054885] Subtest dirty-create: SUCCESS (7.391s)
[577.301345] [117/130] (474s left) syncobj_timeline (single-wait-all-available-submitted)
[577.375773] Starting subtest: single-wait-all-available-submitted
[577.378616] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[577.484617] [118/130] (473s left) gem_partial_pwrite_pread (write-display)
[577.551778] Subtest write-display: SKIP (0.000s)
[577.629689] [119/130] (473s left) perf_pmu (init-sema)
[577.670871] Starting subtest: init-sema
[577.673875] Starting dynamic subtest: rcs0
[577.676735] Dynamic subtest rcs0: SUCCESS (0.002s)
[577.688135] Starting dynamic subtest: bcs0
[577.690702] Dynamic subtest bcs0: SUCCESS (0.001s)
[577.700713] Starting dynamic subtest: vcs0
[577.703734] Dynamic subtest vcs0: SUCCESS (0.001s)
[577.715143] Starting dynamic subtest: vcs1
[577.717661] Dynamic subtest vcs1: SUCCESS (0.001s)
[577.728664] Starting dynamic subtest: vecs0
[577.731373] Dynamic subtest vecs0: SUCCESS (0.001s)
[577.740706] Starting dynamic subtest: ccs0
[577.743011] Dynamic subtest ccs0: SUCCESS (0.001s)
[577.745155] Subtest init-sema: SUCCESS (0.009s)
[577.779689] [120/130] (473s left) gem_lmem_swapping (heavy-verify-multi)
[577.823399] Subtest heavy-verify-multi: SKIP (0.000s)
[577.869504] [121/130] (473s left) api_intel_allocator (gem-pool)
[577.931900] Starting subtest: gem-pool
[577.945463] Subtest gem-pool: SUCCESS (0.016s)
[578.074890] [122/130] (473s left) prime_mmap (test_dup)
[578.134765] Starting subtest: test_dup
[578.137541] Starting dynamic subtest: test_dup-smem
[578.164460] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[578.167470] Subtest test_dup: SUCCESS (0.033s)
[578.235518] [123/130] (473s left) kms_flip (flip-vs-fences)
[578.341912] Starting subtest: flip-vs-fences
[578.346389] Subtest flip-vs-fences: SKIP (0.000s)
[578.431770] [124/130] (473s left) kms_async_flips (crc)
[578.522304] Starting subtest: crc
[578.905860] Starting dynamic subtest: pipe-A-eDP-1
[581.768727] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.860s)
[582.134578] Starting dynamic subtest: pipe-B-eDP-1
[585.057149] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.929s)
[585.422544] Starting dynamic subtest: pipe-C-eDP-1
[588.236367] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.823s)
[588.600290] Starting dynamic subtest: pipe-D-eDP-1
[591.436696] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.845s)
[591.439753] Subtest crc: SUCCESS (12.908s)
[592.589041] [125/130] (459s left) gem_exec_schedule (u-semaphore-user)
[592.667905] Starting subtest: u-semaphore-user
[592.715535] Subtest u-semaphore-user: SUCCESS (0.057s)
[594.602356] [126/130] (457s left) prime_mmap (test_aperture_limit)
[594.668690] Starting subtest: test_aperture_limit
[594.671444] Starting dynamic subtest: test_aperture_limit-smem
[594.677112] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.007s)
[594.679316] Subtest test_aperture_limit: SUCCESS (0.007s)
[594.758587] [127/130] (457s left) gem_wait (write-wait)
[594.829153] Starting subtest: write-wait
[594.831860] Starting dynamic subtest: all-engines
[595.971290] Dynamic subtest all-engines: SUCCESS (1.141s)
[595.987796] Starting dynamic subtest: rcs0
[597.041906] Dynamic subtest rcs0: SUCCESS (1.068s)
[597.059229] Starting dynamic subtest: bcs0
[598.105226] Dynamic subtest bcs0: SUCCESS (1.061s)
[598.121919] Starting dynamic subtest: vcs0
[599.161860] Dynamic subtest vcs0: SUCCESS (1.055s)
[599.178848] Starting dynamic subtest: vcs1
[600.219864] Dynamic subtest vcs1: SUCCESS (1.056s)
[600.237022] Starting dynamic subtest: vecs0
[601.277869] Dynamic subtest vecs0: SUCCESS (1.056s)
[601.294912] Starting dynamic subtest: ccs0
[602.339052] Dynamic subtest ccs0: SUCCESS (1.059s)
[602.341896] Subtest write-wait: SUCCESS (7.508s)
[602.542836] [128/130] (449s left) kms_pm_dc (dc3co-vpb-simulation)
[603.649479] Starting subtest: dc3co-vpb-simulation
[612.577886] Subtest dc3co-vpb-simulation: SKIP (8.923s)
[612.692227] [129/130] (439s left) kms_psr (psr2-cursor-plane-move)
[612.795666] Starting subtest: psr2-cursor-plane-move
[612.798487] Starting dynamic subtest: eDP-1
[614.436152] Dynamic subtest eDP-1: SUCCESS (1.642s)
[614.440798] Subtest psr2-cursor-plane-move: SUCCESS (1.643s)
[615.293234] [130/130] (436s left) i915_selftest (perf)
[617.323127] Starting subtest: perf
[617.326154] Starting dynamic subtest: engine_cs
[620.480559] Dynamic subtest engine_cs: SUCCESS (3.157s)
[620.488840] Starting dynamic subtest: request
[628.060228] Dynamic subtest request: SUCCESS (7.580s)
[628.070478] Starting dynamic subtest: migrate
[631.304567] Dynamic subtest migrate: SUCCESS (3.243s)
[631.315013] Starting dynamic subtest: region
[635.912475] Dynamic subtest region: SUCCESS (4.606s)
[635.915776] Subtest perf: SUCCESS (18.592s)
[635.941156] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[635.941919] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[635.942070] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: drm_read
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: kms_writeback
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip_scaled_crc
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: syncobj_basic
results: parsing output: 15/ for test: kms_draw_crc
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_rotation_crc
results: parsing output: 23/ for test: gem_exec_nop
results: parsing output: 24/ for test: testdisplay
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: kms_hdmi_inject
results: parsing output: 34/ for test: vgem_basic
results: parsing output: 35/ for test: kms_psr
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_bad_reloc
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_exec_basic
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_content_protection
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_multiple
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: prime_self_import
results: parsing output: 52/ for test: kms_chamelium_frames
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_cursor_crc
results: parsing output: 63/ for test: i915_pm_rc6_residency
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_getfb
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: kms_selftest
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: dmabuf_sync_file
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_bad_reloc
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: i915_hangman
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_vblank
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: gem_pread
results: parsing output: 104/ for test: kms_pipe_crc_basic
results: parsing output: 105/ for test: syncobj_eventfd
results: parsing output: 106/ for test: kms_invalid_mode
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: gem_render_copy
results: parsing output: 110/ for test: kms_psr2_sf
results: parsing output: 111/ for test: gem_linear_blits
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: gem_ctx_isolation
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_partial_pwrite_pread
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: gem_lmem_swapping
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: prime_mmap
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_async_flips
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: prime_mmap
results: parsing output: 126/ for test: gem_wait
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: i915_selftest
Done.