[58.080909] Initializing watchdogs
[58.080955]   /dev/watchdog0
[58.094931] [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]
[58.099521] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.101829] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.105676] [001/132] (960s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[58.230241] Starting subtest: flip-vs-dpms-off-vs-modeset
[58.232735] Starting dynamic subtest: A-eDP1
[61.899763] Dynamic subtest A-eDP1: SUCCESS (3.635s)
[61.907300] Starting dynamic subtest: B-eDP1
[65.124729] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[65.132250] Starting dynamic subtest: C-eDP1
[68.214346] Dynamic subtest C-eDP1: SUCCESS (3.078s)
[68.223856] Starting dynamic subtest: D-eDP1
[71.334137] Dynamic subtest D-eDP1: SUCCESS (3.110s)
[71.336388] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.035s)
[72.145761] [002/132] (946s left) gem_ctx_persistence (legacy-engines-mixed-process)
[72.210793] Starting subtest: legacy-engines-mixed-process
[72.213266] Starting dynamic subtest: render
[73.900835] Dynamic subtest render: SUCCESS (1.687s)
[73.910665] Starting dynamic subtest: bsd1
[75.872312] Dynamic subtest bsd1: SUCCESS (1.967s)
[75.882168] Starting dynamic subtest: bsd2
[77.908708] Dynamic subtest bsd2: SUCCESS (2.033s)
[77.918254] Starting dynamic subtest: blt
[79.914676] Dynamic subtest blt: SUCCESS (2.002s)
[79.924098] Starting dynamic subtest: vebox
[81.954704] Dynamic subtest vebox: SUCCESS (2.037s)
[81.957267] Subtest legacy-engines-mixed-process: SUCCESS (9.733s)
[82.030303] [003/132] (936s left) gem_mmap_gtt (cpuset-medium-copy)
[82.087997] Subtest cpuset-medium-copy: SKIP (0.000s)
[82.143152] [004/132] (936s left) perf (short-reads)
[82.249328] Starting subtest: short-reads
[82.264039] Subtest short-reads: SUCCESS (0.015s)
[82.308681] [005/132] (936s left) kms_feature_discovery (display-4x)
[82.397355] Starting subtest: display-4x
[82.401318] Subtest display-4x: SKIP (0.000s)
[82.465649] [006/132] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[82.558993] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[82.563404] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[82.639895] [007/132] (936s left) kms_pipe_crc_basic (nonblocking-crc)
[82.730518] Starting subtest: nonblocking-crc
[82.732659] Starting dynamic subtest: pipe-A-eDP-1
[83.510987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.780s)
[83.521081] Starting dynamic subtest: pipe-B-eDP-1
[84.977563] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.463s)
[84.987341] Starting dynamic subtest: pipe-C-eDP-1
[86.362965] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[86.372627] Starting dynamic subtest: pipe-D-eDP-1
[87.694355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[87.696430] Subtest nonblocking-crc: SUCCESS (4.961s)
[88.499816] [008/132] (930s left) kms_psr (psr-primary-blt)
[88.583822] Starting subtest: psr-primary-blt
[88.586212] Starting dynamic subtest: eDP-1
[90.308948] Dynamic subtest eDP-1: SUCCESS (1.724s)
[90.311384] Subtest psr-primary-blt: SUCCESS (1.725s)
[91.166253] [009/132] (927s left) gem_spin_batch (resubmit)
[91.233977] Starting subtest: resubmit
[91.236606] Starting dynamic subtest: rcs0
[91.241371] Dynamic subtest rcs0: SUCCESS (0.007s)
[91.251183] Starting dynamic subtest: bcs0
[91.253342] Dynamic subtest bcs0: SUCCESS (0.002s)
[91.260579] Starting dynamic subtest: vcs0
[91.262778] Dynamic subtest vcs0: SUCCESS (0.002s)
[91.269763] Starting dynamic subtest: vcs1
[91.271910] Dynamic subtest vcs1: SUCCESS (0.002s)
[91.279806] Starting dynamic subtest: vecs0
[91.281947] Dynamic subtest vecs0: SUCCESS (0.002s)
[91.288949] Starting dynamic subtest: ccs0
[91.291162] Dynamic subtest ccs0: SUCCESS (0.003s)
[91.293303] Subtest resubmit: SUCCESS (0.021s)
[91.485371] [010/132] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[91.578607] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[91.582835] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[91.675802] [011/132] (927s left) kms_selftest (drm_format_helper)
[91.716253] Starting subtest: drm_format_helper
[91.728881] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[91.812532] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.081s)
[91.821676] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[91.902389] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.092s)
[91.911153] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[91.995352] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.093s)
[92.004725] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[92.106506] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.108s)
[92.114798] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[92.191046] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.087s)
[92.199429] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[92.297949] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.106s)
[92.306646] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[92.409353] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.110s)
[92.417080] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[92.502066] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.094s)
[92.509044] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[92.590767] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.086s)
[92.599545] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[92.706724] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.118s)
[92.715941] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[92.796501] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.090s)
[92.805822] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[92.887656] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.091s)
[92.894925] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[93.003525] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.115s)
[93.012940] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[93.102114] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.097s)
[93.111101] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[93.198198] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.096s)
[93.206865] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[93.315342] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.116s)
[93.324233] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[93.427517] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.113s)
[93.429894] Subtest drm_format_helper: SUCCESS (1.709s)
[93.600009] [012/132] (925s left) gem_compute (compute-square)
[93.651373] Starting subtest: compute-square
[93.655087] Subtest compute-square: SUCCESS (0.007s)
[93.772032] [013/132] (925s left) gem_fenced_exec_thrash (2-spare-fences)
[93.837243] Subtest 2-spare-fences: SKIP (0.000s)
[93.903095] [014/132] (925s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[93.968918] Starting subtest: single-wait-all-for-submit-available-signaled
[93.971274] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[94.084838] [015/132] (925s left) sriov_basic (bind-unbind-vf)
[94.148767] Starting subtest: bind-unbind-vf
[94.151288] Starting dynamic subtest: vf-1
[94.222196] Dynamic subtest vf-1: FAIL (0.017s)
[94.230722] Starting dynamic subtest: vf-2
[94.302225] Dynamic subtest vf-2: FAIL (0.004s)
[94.311173] Starting dynamic subtest: vf-3
[94.371842] Dynamic subtest vf-3: FAIL (0.004s)
[94.380161] Starting dynamic subtest: vf-4
[94.437689] Dynamic subtest vf-4: FAIL (0.003s)
[94.446813] Starting dynamic subtest: vf-5
[94.506360] Dynamic subtest vf-5: FAIL (0.004s)
[94.514534] Starting dynamic subtest: vf-6
[94.574520] Dynamic subtest vf-6: FAIL (0.003s)
[94.583751] Starting dynamic subtest: vf-7
[94.645247] Dynamic subtest vf-7: FAIL (0.003s)
[94.653960] Starting dynamic subtest: vf-random
[94.713180] Dynamic subtest vf-random: FAIL (0.003s)
[94.721985] Starting dynamic subtest: vf-last
[94.780655] Dynamic subtest vf-last: FAIL (0.437s)
[94.782524] Subtest bind-unbind-vf: FAIL (0.482s)
[94.815979] [016/132] (924s left) kms_hdr (bpc-switch-suspend)
[94.907165] Starting subtest: bpc-switch-suspend
[95.942763] Starting dynamic subtest: pipe-A-eDP-1
[114.659465] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.593s)
[114.661914] Subtest bpc-switch-suspend: SUCCESS (5.630s)
[114.782255] [017/132] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[114.901017] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[114.905415] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[115.006561] [018/132] (904s left) gem_mmap_wc (coherency)
[115.069477] Subtest coherency: SKIP (0.000s)
[115.124719] [019/132] (904s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[115.248957] Starting subtest: cursor-vs-flip-atomic-transitions
[145.882997] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.326s)
[146.693840] [020/132] (872s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[146.796921] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[146.799101] Starting dynamic subtest: pipe-A-eDP-1
[146.823538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.834132] Starting dynamic subtest: pipe-B-eDP-1
[146.855569] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.863079] Starting dynamic subtest: pipe-C-eDP-1
[146.886011] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.893727] Starting dynamic subtest: pipe-D-eDP-1
[146.916368] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[146.920464] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[148.964043] [021/132] (870s left) gem_exec_reloc (basic-wc-read-active)
[149.029334] Subtest basic-wc-read-active: SKIP (0.000s)
[149.107465] [022/132] (870s left) gem_mmap_wc (write-wc-read-gtt)
[149.164546] Subtest write-wc-read-gtt: SKIP (0.000s)
[149.223214] [023/132] (870s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[149.283418] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[149.386270] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[149.482862] [024/132] (870s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[149.590049] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[149.593963] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[149.659383] [025/132] (869s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[149.752586] Starting subtest: primary-x-tiled-reflect-x-180
[156.624349] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.869s)
[157.856595] [026/132] (861s left) prime_mmap (test_refcounting)
[157.913222] Starting subtest: test_refcounting
[157.915500] Starting dynamic subtest: test_refcounting-smem
[157.946856] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[157.949356] Subtest test_refcounting: SUCCESS (0.035s)
[158.044765] [027/132] (861s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[158.110911] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[158.114834] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[158.287612] [028/132] (861s left) gem_exec_reloc (basic-cpu-read-active)
[158.342395] Subtest basic-cpu-read-active: SKIP (0.000s)
[158.406883] [029/132] (861s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[158.495470] Starting subtest: plane-downscale-factor-0-5-with-rotation
[158.497745] Starting dynamic subtest: pipe-A
[158.514723] Dynamic subtest pipe-A: SKIP (0.015s)
[158.524102] Starting dynamic subtest: pipe-B
[158.542520] Dynamic subtest pipe-B: SKIP (0.029s)
[158.550930] Starting dynamic subtest: pipe-C
[158.576597] Dynamic subtest pipe-C: SKIP (0.032s)
[158.585187] Starting dynamic subtest: pipe-D
[158.606823] Dynamic subtest pipe-D: SKIP (0.030s)
[158.611037] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s)
[158.696580] [030/132] (861s left) kms_prop_blob (blob-multiple)
[158.755225] Starting subtest: blob-multiple
[158.757568] Subtest blob-multiple: SUCCESS (0.002s)
[158.835438] [031/132] (860s left) kms_content_protection (dp-mst-lic-type-1)
[158.991075] Starting subtest: dp-mst-lic-type-1
[158.995549] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[159.102127] [032/132] (860s left) gem_busy (extended)
[159.281881] Starting subtest: extended
[159.284069] Starting dynamic subtest: rcs0
[159.363996] Dynamic subtest rcs0: SUCCESS (0.081s)
[159.376219] Starting dynamic subtest: bcs0
[159.406030] Dynamic subtest bcs0: SUCCESS (0.040s)
[159.417691] Starting dynamic subtest: vcs0
[160.990941] Dynamic subtest vcs0: SUCCESS (1.581s)
[161.003104] Starting dynamic subtest: vcs1
[162.974579] Dynamic subtest vcs1: SUCCESS (1.980s)
[162.987034] Starting dynamic subtest: vecs0
[165.022546] Dynamic subtest vecs0: SUCCESS (2.044s)
[165.033473] Starting dynamic subtest: ccs0
[165.068464] Dynamic subtest ccs0: SUCCESS (0.046s)
[165.071292] Subtest extended: SUCCESS (5.784s)
[165.300580] [033/132] (854s left) gem_ctx_persistence (engines-mixed-process)
[165.349840] Starting subtest: engines-mixed-process
[165.352234] Starting dynamic subtest: rcs0
[167.007330] Dynamic subtest rcs0: SUCCESS (1.656s)
[167.017467] Starting dynamic subtest: bcs0
[168.940800] Dynamic subtest bcs0: SUCCESS (1.932s)
[168.951501] Starting dynamic subtest: vcs0
[170.984135] Dynamic subtest vcs0: SUCCESS (2.041s)
[170.994972] Starting dynamic subtest: vcs1
[172.966007] Dynamic subtest vcs1: SUCCESS (1.979s)
[172.977468] Starting dynamic subtest: vecs0
[174.954743] Dynamic subtest vecs0: SUCCESS (1.986s)
[174.965649] Starting dynamic subtest: ccs0
[176.938554] Dynamic subtest ccs0: SUCCESS (1.982s)
[176.940940] Subtest engines-mixed-process: SUCCESS (11.582s)
[177.015791] [034/132] (842s left) gem_exec_schedule (semaphore-noskip)
[177.086978] Starting subtest: semaphore-noskip
[177.596821] Subtest semaphore-noskip: SUCCESS (0.514s)
[177.950478] [035/132] (841s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[178.053609] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[178.058327] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[179.172700] [036/132] (840s left) gem_exec_fence (keep-in-fence)
[179.345784] Starting subtest: keep-in-fence
[179.348335] Starting dynamic subtest: rcs0
[179.410912] Dynamic subtest rcs0: SUCCESS (0.065s)
[179.423183] Starting dynamic subtest: bcs0
[179.462622] Dynamic subtest bcs0: SUCCESS (0.050s)
[179.474099] Starting dynamic subtest: vcs0
[181.023605] Dynamic subtest vcs0: SUCCESS (1.557s)
[181.035118] Starting dynamic subtest: vcs1
[182.942799] Dynamic subtest vcs1: SUCCESS (1.916s)
[182.954478] Starting dynamic subtest: vecs0
[184.926049] Dynamic subtest vecs0: SUCCESS (1.981s)
[184.936524] Starting dynamic subtest: ccs0
[185.179830] Dynamic subtest ccs0: SUCCESS (0.253s)
[185.182423] Subtest keep-in-fence: SUCCESS (5.832s)
[187.106800] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[187.110356] [037/132] (832s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[187.227696] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[187.232246] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[187.372950] [038/132] (832s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[187.458929] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[187.461065] Starting dynamic subtest: pipe-A-eDP-1
[188.322268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s)
[188.330722] Starting dynamic subtest: pipe-B-eDP-1
[189.985548] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.660s)
[189.999509] Starting dynamic subtest: pipe-C-eDP-1
[191.492910] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s)
[191.502960] Starting dynamic subtest: pipe-D-eDP-1
[193.036115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[193.038507] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.568s)
[194.208720] [039/132] (825s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[194.309014] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[194.313088] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[194.408703] [040/132] (825s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[194.464224] Starting subtest: multi-wait-all-for-submit-unsubmitted
[194.570816] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[194.647010] [041/132] (825s left) vgem_slow (nohang)
[194.687042] Starting subtest: nohang
[205.180548] Subtest nohang: SUCCESS (10.487s)
[205.260279] [042/132] (814s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[205.362967] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[206.198818] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[206.364619] [043/132] (813s left) gem_partial_pwrite_pread (reads)
[206.419898] Subtest reads: SKIP (0.000s)
[206.486763] [044/132] (813s left) perf_pmu (busy-check-all)
[206.525517] Starting subtest: busy-check-all
[206.527415] Starting dynamic subtest: rcs0
[207.076257] Dynamic subtest rcs0: SUCCESS (0.551s)
[207.088327] Starting dynamic subtest: bcs0
[207.629058] Dynamic subtest bcs0: SUCCESS (0.550s)
[207.641198] Starting dynamic subtest: vcs0
[208.989896] Dynamic subtest vcs0: SUCCESS (1.357s)
[209.001921] Starting dynamic subtest: vcs1
[210.974844] Dynamic subtest vcs1: SUCCESS (1.984s)
[210.986687] Starting dynamic subtest: vecs0
[213.021952] Dynamic subtest vecs0: SUCCESS (2.046s)
[213.034125] Starting dynamic subtest: ccs0
[213.576904] Dynamic subtest ccs0: SUCCESS (0.554s)
[213.579597] Subtest busy-check-all: SUCCESS (7.056s)
[213.698259] [045/132] (806s left) core_auth (getclient-simple)
[213.747171] Starting subtest: getclient-simple
[213.766845] Subtest getclient-simple: SUCCESS (0.019s)
[213.881172] [046/132] (806s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[214.255038] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[215.036677] [047/132] (805s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[215.146590] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[215.993342] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.848s)
[216.156982] [048/132] (804s left) i915_pm_rc6_residency (rc6-fence)
[216.218509] Starting subtest: rc6-fence
[216.271507] Starting dynamic subtest: gt0
[228.591913] Dynamic subtest gt0: SUCCESS (12.323s)
[228.603799] Starting dynamic subtest: gt1
[245.917839] Dynamic subtest gt1: SUCCESS (17.322s)
[245.920429] Subtest rc6-fence: SUCCESS (29.704s)
[246.007709] [049/132] (774s left) kms_lease (invalid-create-leases)
[246.108493] Starting subtest: invalid-create-leases
[246.113060] Subtest invalid-create-leases: SUCCESS (0.007s)
[246.232167] [050/132] (774s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[246.292178] Starting subtest: invalid-bsd2-flag-on-blt
[246.294521] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[246.397754] [051/132] (774s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[246.497266] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[251.039566] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.546s)
[252.150137] [052/132] (768s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[252.249360] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[252.251653] Starting dynamic subtest: pipe-A
[252.272039] Dynamic subtest pipe-A: SKIP (0.017s)
[252.285960] Starting dynamic subtest: pipe-B
[252.299852] Dynamic subtest pipe-B: SKIP (0.029s)
[252.309006] Starting dynamic subtest: pipe-C
[252.332468] Dynamic subtest pipe-C: SKIP (0.029s)
[252.341280] Starting dynamic subtest: pipe-D
[252.360192] Dynamic subtest pipe-D: SKIP (0.030s)
[252.363930] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.108s)
[252.472633] [053/132] (768s left) kms_vblank (ts-continuation-dpms-rpm)
[252.578112] Starting subtest: ts-continuation-dpms-rpm
[252.579978] Starting dynamic subtest: pipe-A-eDP-1
[255.131631] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.553s)
[255.146438] Starting dynamic subtest: pipe-D-eDP-1
[257.382765] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.248s)
[257.385109] Subtest ts-continuation-dpms-rpm: SUCCESS (4.805s)
[258.183704] [054/132] (762s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[258.288056] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[265.572035] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.288s)
[265.675888] [055/132] (755s left) i915_drm_fdinfo (virtual-busy-all)
[265.716497] Starting subtest: virtual-busy-all
[265.721030] Subtest virtual-busy-all: SKIP (0.000s)
[265.788332] [056/132] (755s left) kms_cursor_edge_walk (256x256-top-bottom)
[265.874151] Starting subtest: 256x256-top-bottom
[265.876365] Starting dynamic subtest: pipe-A-eDP-1
[269.382875] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[269.393968] Starting dynamic subtest: pipe-D-eDP-1
[272.512218] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[272.514640] Subtest 256x256-top-bottom: SUCCESS (6.637s)
[273.312229] [057/132] (747s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[273.431158] Starting subtest: 4-tiled-16bpp-rotate-270
[273.453460] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[273.564163] [058/132] (747s left) kms_color (invalid-degamma-lut-sizes)
[273.656200] Starting subtest: invalid-degamma-lut-sizes
[273.658352] Starting dynamic subtest: pipe-A
[273.941843] Dynamic subtest pipe-A: SUCCESS (0.284s)
[273.951781] Starting dynamic subtest: pipe-B
[273.954168] Dynamic subtest pipe-B: SUCCESS (0.000s)
[273.963073] Starting dynamic subtest: pipe-C
[273.965471] Dynamic subtest pipe-C: SUCCESS (0.000s)
[273.974251] Starting dynamic subtest: pipe-D
[273.976564] Dynamic subtest pipe-D: SUCCESS (0.001s)
[273.978798] Subtest invalid-degamma-lut-sizes: SUCCESS (0.288s)
[274.748553] [059/132] (746s left) kms_chamelium_edid (hdmi-edid-read)
[275.131004] Subtest hdmi-edid-read: SKIP (0.000s)
[275.960637] [060/132] (745s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[276.061540] Starting subtest: y-tiled-32bpp-rotate-270
[276.065456] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[276.160768] [061/132] (744s left) gem_workarounds (suspend-resume)
[276.229025] Starting subtest: suspend-resume
[291.483622] Subtest suspend-resume: SUCCESS (1.184s)
[291.615022] [062/132] (729s left) kms_psr (psr2-sprite-plane-onoff)
[291.719744] Starting subtest: psr2-sprite-plane-onoff
[291.722024] Starting dynamic subtest: eDP-1
[293.501654] Dynamic subtest eDP-1: SUCCESS (1.713s)
[293.503564] Subtest psr2-sprite-plane-onoff: SUCCESS (1.714s)
[294.405778] [063/132] (726s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[294.503996] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[294.506269] Starting dynamic subtest: pipe-A-eDP-1
[294.662834] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[294.674040] Starting dynamic subtest: pipe-B-eDP-1
[294.694918] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[294.706183] Starting dynamic subtest: pipe-C-eDP-1
[294.725693] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[294.734449] Starting dynamic subtest: pipe-D-eDP-1
[294.754068] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[294.756012] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.154s)
[297.041824] [064/132] (724s left) gem_exec_params (invalid-bsd-ring)
[297.097326] Starting subtest: invalid-bsd-ring
[297.099707] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[297.206634] [065/132] (723s left) gem_exec_schedule (smoketest-all)
[297.283913] Starting subtest: smoketest-all
[329.841530] Subtest smoketest-all: SUCCESS (32.322s)
[331.073853] [066/132] (690s left) gem_userptr_blits (userfault)
[331.146255] Starting subtest: userfault
[331.151406] Subtest userfault: SUCCESS (0.009s)
[331.300388] [067/132] (689s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[331.407101] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[331.409428] Starting dynamic subtest: pipe-A-eDP-1
[331.418501] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[331.433090] Starting dynamic subtest: pipe-B-eDP-1
[331.441591] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[331.453816] Starting dynamic subtest: pipe-C-eDP-1
[331.462810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[331.471258] Starting dynamic subtest: pipe-D-eDP-1
[331.479763] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[331.483950] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[333.609407] [068/132] (687s left) gem_exec_balancer (noheartbeat)
[333.889589] Starting subtest: noheartbeat
[333.894497] Subtest noheartbeat: SKIP (0.000s)
[333.998967] [069/132] (687s left) kms_flip (bo-too-big-interruptible)
[334.088589] Starting subtest: bo-too-big-interruptible
[334.090960] Starting dynamic subtest: A-eDP1
[335.388864] Dynamic subtest A-eDP1: SUCCESS (1.298s)
[335.398704] Starting dynamic subtest: B-eDP1
[336.693769] Dynamic subtest B-eDP1: SUCCESS (1.302s)
[336.705915] Starting dynamic subtest: C-eDP1
[337.942839] Dynamic subtest C-eDP1: SUCCESS (1.247s)
[337.954797] Starting dynamic subtest: D-eDP1
[339.175569] Dynamic subtest D-eDP1: SUCCESS (1.232s)
[339.180289] Subtest bo-too-big-interruptible: SUCCESS (5.090s)
[340.381267] [070/132] (680s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[340.479948] Starting subtest: fbc-pr-cursor-mmap-gtt
[340.484319] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[340.552359] [071/132] (680s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[340.614954] Starting subtest: etime-multi-wait-all-for-submit-submitted
[340.720954] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[340.803647] [072/132] (680s left) core_sysfs (read-all-entries)
[340.859429] Starting subtest: read-all-entries
[340.869729] Subtest read-all-entries: SUCCESS (0.012s)
[340.974465] [073/132] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[341.075550] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[341.079538] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[341.177446] [074/132] (680s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[341.275006] Starting subtest: yf-tiled-8bpp-rotate-0
[341.279158] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[341.362588] [075/132] (680s left) gem_exec_reloc (basic-wc-cpu)
[341.431803] Subtest basic-wc-cpu: SKIP (0.000s)
[341.512367] [076/132] (680s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[341.570570] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[341.572914] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[341.688324] [077/132] (679s left) kms_cursor_crc (cursor-alpha-transparent)
[341.787224] Starting subtest: cursor-alpha-transparent
[341.788844] Starting dynamic subtest: pipe-A-eDP-1
[342.424433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s)
[342.434287] Starting dynamic subtest: pipe-D-eDP-1
[343.669019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s)
[343.670906] Subtest cursor-alpha-transparent: SUCCESS (1.881s)
[344.473082] [078/132] (677s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[344.576476] Starting subtest: fbc-rgb565-draw-mmap-cpu
[348.569828] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (3.996s)
[349.787598] [079/132] (671s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[349.889790] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[349.915954] Starting dynamic subtest: pipe-A-plane-0
[350.204773] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[350.215497] Starting dynamic subtest: pipe-A-plane-3
[350.438565] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[351.573906] Starting dynamic subtest: pipe-B-plane-0
[351.862345] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[351.872584] Starting dynamic subtest: pipe-B-plane-3
[352.095820] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[352.428968] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.538s)
[353.262637] [080/132] (668s left) perf_pmu (faulting-read)
[353.305526] Starting subtest: faulting-read
[353.307869] Starting dynamic subtest: wb
[353.310203] Dynamic subtest wb: SUCCESS (0.001s)
[353.319587] Starting dynamic subtest: wc
[353.321493] Dynamic subtest wc: SUCCESS (0.000s)
[353.330123] Starting dynamic subtest: uc
[353.331959] Dynamic subtest uc: SUCCESS (0.000s)
[353.333780] Subtest faulting-read: SUCCESS (0.003s)
[353.415334] [081/132] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[353.508979] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[353.513074] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[353.613121] [082/132] (668s left) gem_exec_capture (pi)
[353.673625] Starting subtest: pi
[353.675853] Starting dynamic subtest: rcs0
[357.968565] Dynamic subtest rcs0: SUCCESS (4.291s)
[357.981454] Starting dynamic subtest: bcs0
[361.829954] Dynamic subtest bcs0: SUCCESS (3.859s)
[361.843407] Starting dynamic subtest: vcs0
[365.658533] Dynamic subtest vcs0: SUCCESS (3.824s)
[365.671799] Starting dynamic subtest: vcs1
[369.498312] Dynamic subtest vcs1: SUCCESS (3.835s)
[369.510542] Starting dynamic subtest: vecs0
[373.442760] Dynamic subtest vecs0: SUCCESS (3.941s)
[373.454153] Starting dynamic subtest: ccs0
[377.396855] Dynamic subtest ccs0: SUCCESS (3.950s)
[377.399448] Subtest pi: SUCCESS (23.712s)
[377.491738] [083/132] (644s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[377.626994] Starting subtest: fbc-psr2-sprite-mmap-cpu
[377.629172] Starting dynamic subtest: eDP-1
[377.633179] Dynamic subtest eDP-1: SKIP (0.000s)
[377.637351] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[377.706286] [084/132] (644s left) gem_lmem_swapping (heavy-verify-random)
[377.761298] Subtest heavy-verify-random: SKIP (0.000s)
[377.814243] [085/132] (644s left) kms_atomic_transition (plane-all-transition)
[377.912261] Starting subtest: plane-all-transition
[377.914509] Starting dynamic subtest: pipe-A-eDP-1
[380.408083] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[380.717814] Starting dynamic subtest: pipe-B-eDP-1
[383.992072] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[384.289680] Subtest plane-all-transition: SUCCESS (6.375s)
[385.120760] [086/132] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[385.219991] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[385.224516] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[385.334807] [087/132] (636s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[385.438177] Starting subtest: fbc-modesetfrombusy
[389.172881] Subtest fbc-modesetfrombusy: SUCCESS (3.736s)
[390.387679] [088/132] (631s left) gem_exec_params (cliprects_ptr-dirt)
[390.439358] Starting subtest: cliprects_ptr-dirt
[390.441604] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[390.535439] [089/132] (631s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[390.598836] Starting subtest: basic-batch-kernel-default-cmd
[390.603275] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[390.787431] [090/132] (631s left) gem_eio (wait-immediate)
[391.006779] Starting subtest: wait-immediate
[391.347766] Subtest wait-immediate: SUCCESS (0.341s)
[391.474583] [091/132] (630s left) kms_prime (basic-crc-hybrid)
[391.559344] Subtest basic-crc-hybrid: SKIP (0.000s)
[391.652021] [092/132] (630s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[391.745061] Starting subtest: fbc-pr-sprite-mmap-gtt
[391.748470] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[391.828886] [093/132] (630s left) kms_addfb_basic (clobberred-modifier)
[391.894825] Starting subtest: clobberred-modifier
[391.898694] Subtest clobberred-modifier: SKIP (0.000s)
[392.031863] [094/132] (630s left) i915_query (query-regions-sanity-check)
[392.080913] Starting subtest: query-regions-sanity-check
[392.089971] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[392.227684] [095/132] (630s left) gem_pxp (protected-raw-src-copy-not-readible)
[392.339439] Starting subtest: protected-raw-src-copy-not-readible
[392.396136] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.059s)
[392.509770] [096/132] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[392.605553] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[399.903016] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.304s)
[400.045136] [097/132] (622s left) perf (gen8-unprivileged-single-ctx-counters)
[400.152651] Starting subtest: gen8-unprivileged-single-ctx-counters
[400.157504] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[400.199143] [098/132] (622s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[400.299877] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[400.302129] Starting dynamic subtest: pipe-A-eDP-1
[400.418552] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[400.428591] Starting dynamic subtest: pipe-B-eDP-1
[401.610091] Dynamic subtest pipe-B-eDP-1: SKIP (1.190s)
[401.614201] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.314s)
[402.807308] [099/132] (619s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[402.904774] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[402.916705] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s)
[403.016205] [100/132] (619s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[403.104594] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[403.108856] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[403.178407] [101/132] (619s left) prime_self_import (reimport-vs-gem_close-race)
[403.226538] Starting subtest: reimport-vs-gem_close-race
[408.277790] Subtest reimport-vs-gem_close-race: SUCCESS (5.053s)
[408.379840] [102/132] (614s left) syncobj_timeline (invalid-transfer-illegal-handle)
[408.437173] Starting subtest: invalid-transfer-illegal-handle
[408.439539] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[408.517785] [103/132] (614s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[408.621289] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[408.625443] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[408.712173] [104/132] (614s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[408.801799] Starting subtest: blocking-absolute-wf_vblank-interruptible
[408.804189] Starting dynamic subtest: A-eDP1
[417.559107] Dynamic subtest A-eDP1: SUCCESS (8.756s)
[417.573267] Starting dynamic subtest: B-eDP1
[426.281855] Dynamic subtest B-eDP1: SUCCESS (8.720s)
[426.297292] Starting dynamic subtest: C-eDP1
[435.007832] Dynamic subtest C-eDP1: SUCCESS (8.724s)
[435.018711] Starting dynamic subtest: D-eDP1
[443.730203] Dynamic subtest D-eDP1: SUCCESS (8.721s)
[443.736055] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.934s)
[444.945433] [105/132] (577s left) gem_exec_reloc (basic-gtt-active)
[445.007486] Subtest basic-gtt-active: SKIP (0.000s)
[445.125201] [106/132] (577s left) sysfs_preempt_timeout (timeout)
[445.184752] Starting subtest: timeout
[445.186974] Starting dynamic subtest: vecs0
[455.064247] Dynamic subtest vecs0: SUCCESS (9.874s)
[455.075359] Starting dynamic subtest: ccs0
[456.358439] Dynamic subtest ccs0: SUCCESS (1.294s)
[456.371131] Starting dynamic subtest: vcs0
[466.061184] Dynamic subtest vcs0: SUCCESS (9.698s)
[466.075446] Starting dynamic subtest: bcs0
[467.352895] Dynamic subtest bcs0: SUCCESS (1.291s)
[467.364888] Starting dynamic subtest: rcs0
[468.609699] Dynamic subtest rcs0: SUCCESS (1.256s)
[468.621701] Starting dynamic subtest: vcs1
[478.034468] Dynamic subtest vcs1: SUCCESS (9.419s)
[478.037049] Subtest timeout: SUCCESS (32.845s)
[478.116253] [107/132] (544s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[478.214129] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[478.218485] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[478.317246] [108/132] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[478.406159] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[478.410388] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[478.503931] [109/132] (544s left) syncobj_wait (invalid-signal-bad-pad)
[478.553865] Starting subtest: invalid-signal-bad-pad
[478.556164] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[478.646199] [110/132] (544s left) kms_addfb_basic (basic-x-tiled-legacy)
[478.695453] Starting subtest: basic-x-tiled-legacy
[478.699817] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[478.827461] [111/132] (544s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[478.914069] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[483.047349] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.135s)
[484.239060] [112/132] (538s left) kms_pm_rpm (dpms-non-lpsp)
[486.176702] Starting subtest: dpms-non-lpsp
[486.181975] Subtest dpms-non-lpsp: SKIP (0.001s)
[486.559339] [113/132] (536s left) gem_exec_reloc (basic-cpu-active)
[486.628462] Subtest basic-cpu-active: SKIP (0.000s)
[486.713539] [114/132] (536s left) gen9_exec_parse (batch-without-end)
[486.781505] Subtest batch-without-end: SKIP (0.000s)
[486.857293] [115/132] (536s left) gem_exec_params (invalid-fence-in-submit)
[486.928257] Starting subtest: invalid-fence-in-submit
[486.933320] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[487.053076] [116/132] (536s left) gem_exec_whisper (basic-fds-priority-all)
[487.129673] Starting subtest: basic-fds-priority-all
[510.376836] Subtest basic-fds-priority-all: SUCCESS (23.239s)
[510.572328] [117/132] (512s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[510.681287] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[510.685594] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[510.780979] [118/132] (512s left) kms_cursor_crc (cursor-random-256x256)
[511.042548] Starting subtest: cursor-random-256x256
[511.047248] Starting dynamic subtest: pipe-A-eDP-1
[514.467215] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[514.496589] Starting dynamic subtest: pipe-D-eDP-1
[518.513444] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.023s)
[518.515650] Subtest cursor-random-256x256: SUCCESS (7.467s)
[519.314830] [119/132] (504s left) prime_vgem (fence-read-hang)
[519.411558] Subtest fence-read-hang: SKIP (0.000s)
[519.535614] [120/132] (504s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[519.629226] Starting subtest: x-tiled-8bpp-rotate-90
[519.649509] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[519.779250] [121/132] (503s left) gem_exec_reloc (basic-wc-cpu-active)
[519.839664] Subtest basic-wc-cpu-active: SKIP (0.000s)
[519.906466] [122/132] (503s left) gem_eio (in-flight-1us)
[520.125576] Starting subtest: in-flight-1us
[528.939092] Subtest in-flight-1us: SUCCESS (8.809s)
[529.106799] [123/132] (494s left) gem_exec_schedule (pi-userfault)
[529.291193] Starting subtest: pi-userfault
[529.293313] Starting dynamic subtest: rcs0
[529.300645] Dynamic subtest rcs0: SUCCESS (0.011s)
[529.315380] Starting dynamic subtest: bcs0
[529.317692] Dynamic subtest bcs0: SUCCESS (0.009s)
[529.327631] Starting dynamic subtest: vcs0
[529.329590] Dynamic subtest vcs0: SUCCESS (0.011s)
[529.339384] Starting dynamic subtest: vcs1
[529.341719] Dynamic subtest vcs1: SUCCESS (0.008s)
[529.351637] Starting dynamic subtest: vecs0
[529.353799] Dynamic subtest vecs0: SUCCESS (0.009s)
[529.363503] Starting dynamic subtest: ccs0
[529.365683] Dynamic subtest ccs0: SUCCESS (0.010s)
[529.367896] Subtest pi-userfault: SUCCESS (0.062s)
[529.546882] [124/132] (494s left) gem_mmap_offset (mmap-unmap)
[529.607635] Starting subtest: mmap-unmap
[529.609662] Starting dynamic subtest: smem0
[552.146876] Dynamic subtest smem0: SUCCESS (22.533s)
[552.149717] Subtest mmap-unmap: SUCCESS (22.534s)
[552.256984] [125/132] (471s left) kms_atomic (crtc-invalid-params)
[552.353718] Starting subtest: crtc-invalid-params
[552.356213] Starting dynamic subtest: pipe-A-eDP-1
[552.722986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.368s)
[552.725213] Subtest crtc-invalid-params: SUCCESS (0.370s)
[553.552773] [126/132] (470s left) gem_softpin (noreloc-interruptible)
[553.613009] Starting subtest: noreloc-interruptible
[559.010441] Subtest noreloc-interruptible: SUCCESS (5.397s)
[559.149933] [127/132] (464s left) kms_invalid_mode (zero-clock)
[559.269479] Starting subtest: zero-clock
[559.271596] Starting dynamic subtest: pipe-A-eDP-1
[559.552362] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[559.563148] Starting dynamic subtest: pipe-B-eDP-1
[559.565264] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[559.575293] Starting dynamic subtest: pipe-C-eDP-1
[559.577175] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[559.589338] Starting dynamic subtest: pipe-D-eDP-1
[559.591257] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[559.593147] Subtest zero-clock: SUCCESS (0.293s)
[560.399561] [128/132] (463s left) kms_psr (pr-primary-mmap-gtt)
[560.500913] Starting subtest: pr-primary-mmap-gtt
[560.505392] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[560.584367] [129/132] (463s left) sw_sync (alloc_merge_fence)
[560.626162] Starting subtest: alloc_merge_fence
[560.628237] Subtest alloc_merge_fence: SUCCESS (0.000s)
[560.683392] [130/132] (463s left) prime_mmap (test_aperture_limit)
[560.740904] Starting subtest: test_aperture_limit
[560.742774] Starting dynamic subtest: test_aperture_limit-smem
[560.749367] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[560.753259] Subtest test_aperture_limit: SKIP (0.008s)
[560.848492] [131/132] (463s left) i915_hangman (gt-engine-error)
[560.923499] Starting subtest: gt-engine-error
[560.925727] Starting dynamic subtest: rcs0
[562.034777] Dynamic subtest rcs0: SUCCESS (1.110s)
[562.051431] Starting dynamic subtest: bcs0
[564.018695] Dynamic subtest bcs0: SUCCESS (1.981s)
[564.031932] Starting dynamic subtest: vcs0
[566.066307] Dynamic subtest vcs0: SUCCESS (2.044s)
[566.079843] Starting dynamic subtest: vcs1
[568.051403] Dynamic subtest vcs1: SUCCESS (1.982s)
[568.064575] Starting dynamic subtest: vecs0
[570.034416] Dynamic subtest vecs0: SUCCESS (1.980s)
[570.057974] Starting dynamic subtest: ccs0
[572.019392] Dynamic subtest ccs0: SUCCESS (1.981s)
[572.022524] Subtest gt-engine-error: SUCCESS (11.094s)
[572.108254] [132/132] (451s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[572.208727] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[572.212699] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[572.281663] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_ctx_persistence
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_feature_discovery
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_pipe_crc_basic
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: gem_spin_batch
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: gem_compute
results: parsing output: 12/ for test: gem_fenced_exec_thrash
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: sriov_basic
results: parsing output: 15/ for test: kms_hdr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_mmap_wc
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_rotation_crc
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: kms_prop_blob
results: parsing output: 30/ for test: kms_content_protection
results: parsing output: 31/ for test: gem_busy
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_fence
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: vgem_slow
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: perf_pmu
results: parsing output: 44/ for test: core_auth
results: parsing output: 45/ for test: kms_chamelium_hpd
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: i915_pm_rc6_residency
results: parsing output: 48/ for test: kms_lease
results: parsing output: 49/ for test: gem_exec_params
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: kms_vblank
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_color
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_workarounds
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: gem_exec_params
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: core_sysfs
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_capture
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_exec_flush
results: parsing output: 89/ for test: gem_eio
results: parsing output: 90/ for test: kms_prime
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: gem_pxp
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: kms_psr2_sf
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: prime_self_import
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_reloc
results: parsing output: 105/ for test: sysfs_preempt_timeout
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_wait
results: parsing output: 109/ for test: kms_addfb_basic
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_pm_rpm
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: gem_exec_params
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_eio
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: gem_mmap_offset
results: parsing output: 124/ for test: kms_atomic
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: kms_invalid_mode
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_flip_scaled_crc
Done.