[63.057801] Initializing watchdogs
[63.057852]   /dev/watchdog0
[63.073199] [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]
[63.077661] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.079995] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.084185] [001/133] (960s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[63.223042] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[63.236081] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[63.349646] [002/133] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[63.455766] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[63.458143] Starting dynamic subtest: pipe-A-eDP-1
[63.481282] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.491257] Starting dynamic subtest: pipe-B-eDP-1
[63.513056] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.520369] Starting dynamic subtest: pipe-C-eDP-1
[63.542430] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.549975] Starting dynamic subtest: pipe-D-eDP-1
[63.572171] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.576269] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[65.794593] [003/133] (957s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[65.910716] Starting subtest: y-tiled-16bpp-rotate-180
[65.914965] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[66.020558] [004/133] (957s left) gem_caching (writes)
[66.080587] Subtest writes: SKIP (0.000s)
[66.146563] [005/133] (957s left) gem_mmap_gtt (cpuset-big-copy)
[66.199879] Subtest cpuset-big-copy: SKIP (0.000s)
[66.251882] [006/133] (957s left) sw_sync (sync_multi_consumer)
[66.285431] Starting subtest: sync_multi_consumer
[66.712604] Subtest sync_multi_consumer: SUCCESS (0.429s)
[66.784462] [007/133] (957s left) kms_psr (fbc-psr-primary-blt)
[66.872057] Starting subtest: fbc-psr-primary-blt
[66.874345] Starting dynamic subtest: eDP-1
[66.878404] Dynamic subtest eDP-1: SKIP (0.000s)
[66.882448] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[66.957600] [008/133] (956s left) prime_busy (after-wait)
[67.013673] Starting subtest: after-wait
[67.018377] Starting dynamic subtest: rcs0
[67.046304] Dynamic subtest rcs0: SUCCESS (0.030s)
[67.056278] Starting dynamic subtest: bcs0
[67.088153] Dynamic subtest bcs0: SUCCESS (0.041s)
[67.097155] Starting dynamic subtest: vcs0
[67.129037] Dynamic subtest vcs0: SUCCESS (0.041s)
[67.138022] Starting dynamic subtest: vcs1
[67.169326] Dynamic subtest vcs1: SUCCESS (0.040s)
[67.178225] Starting dynamic subtest: vecs0
[67.211021] Dynamic subtest vecs0: SUCCESS (0.041s)
[67.220148] Starting dynamic subtest: ccs0
[67.252469] Dynamic subtest ccs0: SUCCESS (0.041s)
[67.360618] Subtest after-wait: SUCCESS (0.346s)
[67.443880] [009/133] (956s left) i915_query (query-topology-unsupported)
[67.501277] Starting subtest: query-topology-unsupported
[67.505944] Subtest query-topology-unsupported: SKIP (0.000s)
[67.608961] [010/133] (956s left) kms_cursor_crc (cursor-onscreen-32x32)
[67.758655] Starting subtest: cursor-onscreen-32x32
[67.806287] Subtest cursor-onscreen-32x32: SKIP (0.044s)
[68.097789] [011/133] (955s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[68.198498] Starting subtest: fb-8bpc-vs-panel-8bpc
[68.200801] Starting dynamic subtest: pipe-A-eDP-1
[69.549808] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.355s)
[69.552314] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.356s)
[70.433129] [012/133] (953s left) gem_eio (in-flight-contexts-1us)
[70.609119] Starting subtest: in-flight-contexts-1us
[84.312292] Subtest in-flight-contexts-1us: SUCCESS (13.710s)
[84.485796] [013/133] (939s left) kms_addfb_basic (basic-x-tiled-legacy)
[84.546818] Starting subtest: basic-x-tiled-legacy
[84.550893] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[84.686119] [014/133] (939s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[84.745787] Starting subtest: multi-wait-all-for-submit-signaled
[84.748130] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[84.863077] [015/133] (939s left) syncobj_eventfd (timeline-wait-before-signal)
[84.921751] Starting subtest: timeline-wait-before-signal
[84.951657] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[85.027204] [016/133] (939s left) gem_pwrite_snooped
[85.158043] [017/133] (939s left) kms_fbcon_fbt (fbc-suspend)
[85.216667] Starting subtest: fbc-suspend
[134.475249] Subtest fbc-suspend: SUCCESS (20.266s)
[135.843386] [018/133] (888s left) gen9_exec_parse (bb-secure)
[135.906467] Subtest bb-secure: SKIP (0.000s)
[135.967216] [019/133] (888s left) perf_pmu (frequency)
[136.002360] Starting subtest: frequency
[136.007695] Starting dynamic subtest: gt0
[138.102981] Dynamic subtest gt0: SUCCESS (2.102s)
[138.113902] Starting dynamic subtest: idle-gt0
[138.625511] Dynamic subtest idle-gt0: SUCCESS (0.525s)
[138.637780] Starting dynamic subtest: gt1
[143.421551] Dynamic subtest gt1: SUCCESS (4.805s)
[143.433439] Starting dynamic subtest: idle-gt1
[143.925282] Dynamic subtest idle-gt1: SUCCESS (0.506s)
[143.928159] Subtest frequency: SUCCESS (7.952s)
[144.010649] [020/133] (880s left) kms_feature_discovery (display)
[144.121428] Starting subtest: display
[144.123784] Subtest display: SUCCESS (0.000s)
[144.207337] [021/133] (880s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[144.309951] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[144.314795] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[144.400482] [022/133] (879s left) syncobj_timeline (invalid-query-bad-pad)
[144.446845] Starting subtest: invalid-query-bad-pad
[144.449074] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[144.535722] [023/133] (879s left) gem_bad_reloc (negative-reloc-lut)
[144.589866] Subtest negative-reloc-lut: SKIP (0.000s)
[144.662344] [024/133] (879s left) i915_pm_rpm (debugfs-forcewake-user)
[146.620255] Starting subtest: debugfs-forcewake-user
[158.007559] Subtest debugfs-forcewake-user: SUCCESS (11.404s)
[158.396520] [025/133] (866s left) kms_psr (pr-sprite-render)
[158.501621] Starting subtest: pr-sprite-render
[158.505595] Subtest pr-sprite-render: SKIP (0.000s)
[158.584096] [026/133] (865s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[158.642104] Starting subtest: multi-wait-for-submit-submitted-signaled
[158.644502] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[158.742883] [027/133] (865s left) gem_linear_blits (normal)
[159.113895] Starting subtest: normal
[162.827912] Subtest normal: SUCCESS (3.715s)
[162.985549] [028/133] (861s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[163.155258] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[163.159727] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[163.246932] [029/133] (861s left) gem_exec_reloc (basic-range-active)
[163.308324] Subtest basic-range-active: SKIP (0.000s)
[163.374129] [030/133] (861s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[163.493947] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[164.649454] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: FAIL (0.559s)
[164.689229] [031/133] (860s left) kms_pm_dc (dc5-dpms-negative)
[165.795991] Starting subtest: dc5-dpms-negative
[165.800615] Subtest dc5-dpms-negative: SKIP (0.000s)
[165.871648] [032/133] (858s left) kms_chamelium_frames (hdmi-crc-fast)
[166.259731] Subtest hdmi-crc-fast: SKIP (0.000s)
[167.094225] [033/133] (857s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[167.168575] Starting subtest: yf-tiled-ccs-to-y-tiled
[167.173334] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[167.349343] [034/133] (857s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[167.454729] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[167.459059] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[167.552575] [035/133] (857s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[167.658482] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[167.663050] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[167.763740] [036/133] (857s left) perf_pmu (rc6)
[167.805045] Starting subtest: rc6
[167.807393] Starting dynamic subtest: gt0
[174.165647] Dynamic subtest gt0: SUCCESS (6.360s)
[174.178831] Starting dynamic subtest: runtime-pm-gt0
[181.980076] Dynamic subtest runtime-pm-gt0: SUCCESS (7.815s)
[181.993567] Starting dynamic subtest: runtime-pm-long-gt0
[194.486231] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.509s)
[194.497704] Starting dynamic subtest: other-idle-gt0
[200.829368] Dynamic subtest other-idle-gt0: SUCCESS (6.344s)
[200.840602] Starting dynamic subtest: gt1
[207.171074] Dynamic subtest gt1: SUCCESS (6.342s)
[207.182101] Starting dynamic subtest: runtime-pm-gt1
[214.689814] Dynamic subtest runtime-pm-gt1: SUCCESS (7.520s)
[214.702741] Starting dynamic subtest: runtime-pm-long-gt1
[227.112367] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.426s)
[227.125496] Starting dynamic subtest: other-idle-gt1
[233.458157] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[233.461113] Subtest rc6: SUCCESS (65.666s)
[234.599662] [037/133] (790s left) syncobj_wait (reset-signaled)
[234.655575] Starting subtest: reset-signaled
[234.657836] Subtest reset-signaled: SUCCESS (0.000s)
[234.727510] [038/133] (790s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[234.818766] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[234.820610] Starting dynamic subtest: pipe-A
[234.840739] Dynamic subtest pipe-A: SKIP (0.019s)
[234.852373] Starting dynamic subtest: pipe-B
[234.879203] Dynamic subtest pipe-B: SKIP (0.038s)
[234.890345] Starting dynamic subtest: pipe-C
[234.917602] Dynamic subtest pipe-C: SKIP (0.038s)
[234.927517] Starting dynamic subtest: pipe-D
[234.950414] Dynamic subtest pipe-D: SKIP (0.033s)
[234.953932] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.130s)
[235.045388] [039/133] (790s left) gem_ctx_param (invalid-set-no-zeromap)
[235.096436] Starting subtest: invalid-set-no-zeromap
[235.098487] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[235.149927] [040/133] (790s left) kms_psr (psr-sprite-mmap-gtt)
[235.241374] Starting subtest: psr-sprite-mmap-gtt
[235.243369] Starting dynamic subtest: eDP-1
[236.717565] Dynamic subtest eDP-1: SKIP (1.471s)
[236.722315] Subtest psr-sprite-mmap-gtt: SKIP (1.472s)
[236.871310] [041/133] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[236.964181] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[244.292417] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.330s)
[244.383322] [042/133] (780s left) kms_addfb_basic (basic)
[244.439265] Starting subtest: basic
[244.441536] Subtest basic: SUCCESS (0.000s)
[244.546302] [043/133] (780s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[244.598116] Starting subtest: etime-single-wait-for-submit-unsubmitted
[244.703429] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[244.754277] [044/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[244.840681] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[252.620510] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.782s)
[252.722115] [045/133] (772s left) gem_exec_balancer (bonded-sync)
[252.786865] Starting subtest: bonded-sync
[252.791360] Subtest bonded-sync: SKIP (0.000s)
[253.090983] [046/133] (772s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[253.188820] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[254.023930] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[254.163509] [047/133] (771s left) gem_exec_fence (syncobj-export)
[254.645043] Starting subtest: syncobj-export
[254.650197] Subtest syncobj-export: SUCCESS (0.005s)
[256.502957] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true
[256.506208] [048/133] (768s left) kms_cursor_edge_walk (256x256-top-bottom)
[256.618594] Starting subtest: 256x256-top-bottom
[256.620978] Starting dynamic subtest: pipe-A-eDP-1
[260.392439] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.775s)
[260.404043] Starting dynamic subtest: pipe-D-eDP-1
[263.607071] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.212s)
[263.609260] Subtest 256x256-top-bottom: SUCCESS (6.989s)
[264.402057] [049/133] (761s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[264.493907] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[271.352909] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.862s)
[271.481466] [050/133] (754s left) kms_psr (psr2-sprite-mmap-gtt)
[271.589550] Starting subtest: psr2-sprite-mmap-gtt
[271.591788] Starting dynamic subtest: eDP-1
[273.042937] Dynamic subtest eDP-1: SKIP (1.449s)
[273.047894] Subtest psr2-sprite-mmap-gtt: SKIP (1.451s)
[273.175961] [051/133] (752s left) kms_psr2_su (page_flip-nv12)
[273.223025] Subtest page_flip-NV12: SKIP (0.000s)
[273.292666] [052/133] (752s left) gem_mmap_gtt (fault-concurrent)
[273.346879] Subtest fault-concurrent: SKIP (0.000s)
[273.407625] [053/133] (752s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[273.506339] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[273.508553] Starting dynamic subtest: pipe-A
[273.641235] Dynamic subtest pipe-A: SKIP (0.131s)
[273.653008] Starting dynamic subtest: pipe-B
[274.844529] Dynamic subtest pipe-B: SKIP (1.204s)
[274.855855] Starting dynamic subtest: pipe-C
[276.082001] Dynamic subtest pipe-C: SUCCESS (1.241s)
[276.093083] Starting dynamic subtest: pipe-D
[277.324425] Dynamic subtest pipe-D: SUCCESS (1.242s)
[277.326803] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.821s)
[278.516535] [054/133] (747s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[278.566671] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[278.625502] [055/133] (747s left) kms_atomic_interruptible (legacy-pageflip)
[278.729627] Starting subtest: legacy-pageflip
[278.731951] Starting dynamic subtest: pipe-A-eDP-1
[286.141516] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.411s)
[286.143768] Subtest legacy-pageflip: SUCCESS (7.412s)
[286.972717] [056/133] (738s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[287.078936] Starting subtest: psr-rgb565-draw-pwrite
[294.219986] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.145s)
[294.315715] [057/133] (731s left) syncobj_wait (invalid-wait-bad-flags)
[294.371002] Starting subtest: invalid-wait-bad-flags
[294.373351] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[294.463852] [058/133] (731s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[294.559408] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[294.572231] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[294.630589] [059/133] (731s left) perf (gen12-unprivileged-single-ctx-counters)
[294.733964] Starting subtest: gen12-unprivileged-single-ctx-counters
[294.735875] Starting dynamic subtest: rcs0
[294.775426] Dynamic subtest rcs0: SUCCESS (0.042s)
[294.777795] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.043s)
[294.830675] [060/133] (731s left) gem_exec_schedule (preemptive-hang)
[295.042127] Starting subtest: preemptive-hang
[295.044100] Starting dynamic subtest: rcs0
[304.554932] Dynamic subtest rcs0: SUCCESS (9.514s)
[304.567885] Starting dynamic subtest: bcs0
[313.507898] Dynamic subtest bcs0: SUCCESS (8.955s)
[313.522155] Starting dynamic subtest: vcs0
[322.596337] Dynamic subtest vcs0: SUCCESS (9.086s)
[322.609903] Starting dynamic subtest: vcs1
[331.555322] Dynamic subtest vcs1: SUCCESS (8.962s)
[331.568826] Starting dynamic subtest: vecs0
[340.512092] Dynamic subtest vecs0: SUCCESS (8.959s)
[340.522773] Starting dynamic subtest: ccs0
[349.539003] Dynamic subtest ccs0: SUCCESS (9.027s)
[349.541392] Subtest preemptive-hang: SUCCESS (54.514s)
[349.762524] [061/133] (676s left) kms_selftest (drm_cmdline_parser)
[349.802640] Starting subtest: drm_cmdline_parser
[349.817527] Starting dynamic subtest: drm_test_cmdline_force_d_only
[349.985165] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.166s)
[349.996160] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[350.108763] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.122s)
[350.119164] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[350.233635] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.124s)
[350.244104] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[350.336874] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.103s)
[350.347183] Starting dynamic subtest: drm_test_cmdline_force_e_only
[350.479261] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.141s)
[350.491501] Starting dynamic subtest: drm_test_cmdline_res
[350.579293] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.098s)
[350.589914] Starting dynamic subtest: drm_test_cmdline_res_vesa
[350.685394] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.106s)
[350.697531] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[350.780410] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.094s)
[350.792667] Starting dynamic subtest: drm_test_cmdline_res_rblank
[350.869149] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.088s)
[350.879468] Starting dynamic subtest: drm_test_cmdline_res_bpp
[350.955448] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.086s)
[350.966058] Starting dynamic subtest: drm_test_cmdline_res_refresh
[351.059339] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.101s)
[351.070186] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[351.169704] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.112s)
[351.181215] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[351.257289] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.084s)
[351.269474] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[351.357375] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.099s)
[351.367687] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[351.452338] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.094s)
[351.464789] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[351.556849] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.105s)
[351.567285] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[351.657466] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.099s)
[351.669913] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[351.749759] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.090s)
[351.762359] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[351.844673] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.093s)
[351.856843] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[351.958811] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.113s)
[351.971327] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[352.056054] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.096s)
[352.066375] Starting dynamic subtest: drm_test_cmdline_name
[352.152822] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.096s)
[352.163241] Starting dynamic subtest: drm_test_cmdline_name_bpp
[352.256736] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.102s)
[352.267090] Starting dynamic subtest: drm_test_cmdline_name_option
[352.356567] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.098s)
[352.368943] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[352.452875] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.095s)
[352.462787] Starting dynamic subtest: drm_test_cmdline_rotate_0
[352.561800] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.108s)
[352.572034] Starting dynamic subtest: drm_test_cmdline_rotate_90
[352.650935] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.088s)
[352.660791] Starting dynamic subtest: drm_test_cmdline_rotate_180
[352.755144] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.104s)
[352.767686] Starting dynamic subtest: drm_test_cmdline_rotate_270
[352.849291] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.092s)
[352.860858] Starting dynamic subtest: drm_test_cmdline_hmirror
[352.946673] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.096s)
[352.958666] Starting dynamic subtest: drm_test_cmdline_vmirror
[353.046757] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.099s)
[353.058928] Starting dynamic subtest: drm_test_cmdline_margin_options
[353.141797] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.093s)
[353.153363] Starting dynamic subtest: drm_test_cmdline_multiple_options
[353.251185] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.109s)
[353.261202] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[353.358908] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.107s)
[353.369021] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[353.463129] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.103s)
[353.476714] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[353.567458] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.104s)
[353.579165] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[353.661036] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.093s)
[353.673068] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[353.758330] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.094s)
[353.769547] Starting dynamic subtest: drm_test_cmdline_invalid
[353.844636] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.087s)
[353.854677] Starting dynamic subtest: drm_test_cmdline_tv_options
[353.976080] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.128s)
[353.978427] Subtest drm_cmdline_parser: SUCCESS (4.174s)
[354.120311] [062/133] (671s left) gem_exec_reloc (basic-wc-gtt-active)
[354.191429] Subtest basic-wc-gtt-active: SKIP (0.000s)
[354.268689] [063/133] (671s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[354.361182] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[354.363510] Starting dynamic subtest: pipe-A-eDP-1
[354.372722] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.386008] Starting dynamic subtest: pipe-B-eDP-1
[354.395361] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.408725] Starting dynamic subtest: pipe-C-eDP-1
[354.417066] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.427773] Starting dynamic subtest: pipe-D-eDP-1
[354.436170] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.440188] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[356.643146] [064/133] (669s left) kms_lease (lease-invalid-plane)
[356.748438] Starting subtest: lease-invalid-plane
[356.750786] Starting dynamic subtest: pipe-A-eDP-1
[356.752997] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[356.765845] Starting dynamic subtest: pipe-B-eDP-1
[356.767787] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[356.778229] Starting dynamic subtest: pipe-C-eDP-1
[356.780091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[356.790545] Starting dynamic subtest: pipe-D-eDP-1
[356.792422] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[356.794320] Subtest lease-invalid-plane: SUCCESS (0.004s)
[356.843450] [065/133] (669s left) i915_query (query-topology-matches-eu-total)
[356.903309] Starting subtest: query-topology-matches-eu-total
[356.905430] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[356.983332] [066/133] (669s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[357.089565] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[357.093445] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[357.167435] [067/133] (669s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[357.271028] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[357.273911] Starting dynamic subtest: pipe-A-default-mode
[359.993393] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[359.995767] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.722s)
[360.830196] [068/133] (665s left) kms_pm_rpm (pc8-residency)
[362.556789] Starting subtest: pc8-residency
[362.561704] Subtest pc8-residency: SKIP (0.000s)
[363.078474] [069/133] (663s left) gem_exec_schedule (u-fairslice)
[363.146402] Starting subtest: u-fairslice
[363.148231] Starting dynamic subtest: rcs0
[365.162314] Dynamic subtest rcs0: SUCCESS (2.021s)
[365.173246] Starting dynamic subtest: bcs0
[367.183169] Dynamic subtest bcs0: SUCCESS (2.017s)
[367.193940] Starting dynamic subtest: vcs0
[369.204802] Dynamic subtest vcs0: SUCCESS (2.018s)
[369.218530] Starting dynamic subtest: vcs1
[371.224576] Dynamic subtest vcs1: SUCCESS (2.020s)
[371.236241] Starting dynamic subtest: vecs0
[373.244476] Dynamic subtest vecs0: SUCCESS (2.019s)
[373.256057] Starting dynamic subtest: ccs0
[375.276418] Dynamic subtest ccs0: SUCCESS (2.025s)
[375.278782] Subtest u-fairslice: SUCCESS (12.129s)
[375.558376] [070/133] (650s left) kms_plane_scaling (2x-scaler-multi-pipe)
[375.662356] Starting subtest: 2x-scaler-multi-pipe
[375.666859] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[375.743249] [071/133] (650s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[375.833817] Starting subtest: fbc-psr2-cursor-mmap-cpu
[375.836042] Starting dynamic subtest: eDP-1
[375.840068] Dynamic subtest eDP-1: SKIP (0.000s)
[375.844426] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[375.888988] [072/133] (650s left) gem_ctx_persistence (legacy-engines-hostile)
[375.940691] Starting subtest: legacy-engines-hostile
[375.943043] Starting dynamic subtest: render
[376.017191] Dynamic subtest render: SUCCESS (0.076s)
[376.030537] Starting dynamic subtest: bsd1
[376.106986] Dynamic subtest bsd1: SUCCESS (0.087s)
[376.119727] Starting dynamic subtest: bsd2
[376.205784] Dynamic subtest bsd2: SUCCESS (0.096s)
[376.221977] Starting dynamic subtest: blt
[376.298061] Dynamic subtest blt: SUCCESS (0.089s)
[376.314590] Starting dynamic subtest: vebox
[376.390145] Dynamic subtest vebox: SUCCESS (0.089s)
[376.392743] Subtest legacy-engines-hostile: SUCCESS (0.451s)
[376.451058] [073/133] (650s left) kms_plane_multiple (tiling-none)
[376.543337] Starting subtest: tiling-none
[376.545261] Starting dynamic subtest: pipe-A-eDP-1
[380.405196] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.858s)
[380.417133] Starting dynamic subtest: pipe-B-eDP-1
[385.122372] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.717s)
[385.136162] Starting dynamic subtest: pipe-C-eDP-1
[389.573259] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.447s)
[389.584328] Starting dynamic subtest: pipe-D-eDP-1
[393.971402] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.397s)
[393.973654] Subtest tiling-none: SUCCESS (17.423s)
[394.774371] [074/133] (631s left) gem_exec_fence (basic-wait)
[394.954958] Starting subtest: basic-wait
[394.957371] Starting dynamic subtest: rcs0
[395.029138] Dynamic subtest rcs0: SUCCESS (0.074s)
[395.042522] Starting dynamic subtest: bcs0
[395.098085] Dynamic subtest bcs0: SUCCESS (0.067s)
[395.111651] Starting dynamic subtest: vcs0
[395.163846] Dynamic subtest vcs0: SUCCESS (0.063s)
[395.177199] Starting dynamic subtest: vcs1
[395.215440] Dynamic subtest vcs1: SUCCESS (0.050s)
[395.227685] Starting dynamic subtest: vecs0
[395.280345] Dynamic subtest vecs0: SUCCESS (0.062s)
[395.293292] Starting dynamic subtest: ccs0
[395.344480] Dynamic subtest ccs0: SUCCESS (0.062s)
[395.347882] Subtest basic-wait: SUCCESS (0.391s)
[397.502481] [075/133] (629s left) syncobj_timeline (wait-for-submit-delayed-submit)
[397.567106] Starting subtest: wait-for-submit-delayed-submit
[397.668823] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[397.728382] [076/133] (628s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[397.826426] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[397.828763] Starting dynamic subtest: pipe-A-eDP-1
[398.119712] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.263s)
[398.133482] Starting dynamic subtest: pipe-B-eDP-1
[399.381366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[399.392668] Starting dynamic subtest: pipe-C-eDP-1
[400.668198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[400.679515] Starting dynamic subtest: pipe-D-eDP-1
[401.902336] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[401.904286] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.046s)
[403.008693] [077/133] (623s left) gem_vm_create (invalid-create)
[403.059354] Starting subtest: invalid-create
[403.061674] Subtest invalid-create: SUCCESS (0.002s)
[403.138508] [078/133] (623s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[403.252179] Starting subtest: flip-vs-cursor-varying-size
[412.381097] Subtest flip-vs-cursor-varying-size: SUCCESS (9.128s)
[413.241673] [079/133] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[413.344358] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[419.944410] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.604s)
[420.036869] [080/133] (606s left) api_intel_bb (lot-of-buffers)
[420.094832] Starting subtest: lot-of-buffers
[421.163174] Subtest lot-of-buffers: SUCCESS (1.071s)
[421.518341] [081/133] (605s left) gem_pxp (create-regular-context-1)
[421.639376] Starting subtest: create-regular-context-1
[421.642197] Subtest create-regular-context-1: SUCCESS (0.001s)
[421.725218] [082/133] (605s left) gem_userptr_blits (usage-restrictions)
[421.798392] Starting subtest: usage-restrictions
[421.800563] Subtest usage-restrictions: SUCCESS (0.000s)
[421.900304] [083/133] (605s left) kms_chamelium_hpd (hdmi-hpd)
[422.277894] Subtest hdmi-hpd: SKIP (0.000s)
[423.092536] [084/133] (603s left) i915_query (query-regions-garbage-items)
[423.157756] Starting subtest: query-regions-garbage-items
[423.159626] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[423.246178] [085/133] (603s left) gem_exec_parallel (userptr)
[423.305140] Starting subtest: userptr
[423.307496] Starting dynamic subtest: rcs0
[424.745098] Dynamic subtest rcs0: SUCCESS (1.439s)
[424.757735] Starting dynamic subtest: bcs0
[426.234353] Dynamic subtest bcs0: SUCCESS (1.487s)
[426.248475] Starting dynamic subtest: vcs0
[428.346543] Dynamic subtest vcs0: SUCCESS (2.109s)
[428.362367] Starting dynamic subtest: vcs1
[430.394276] Dynamic subtest vcs1: SUCCESS (2.045s)
[430.408161] Starting dynamic subtest: vecs0
[432.379811] Dynamic subtest vecs0: SUCCESS (1.982s)
[432.395369] Starting dynamic subtest: ccs0
[433.900046] Dynamic subtest ccs0: SUCCESS (1.519s)
[433.902510] Subtest userptr: SUCCESS (10.596s)
[434.067236] [086/133] (593s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[434.166725] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[434.169135] Starting dynamic subtest: pipe-A-eDP-1
[434.190086] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[434.205127] Starting dynamic subtest: pipe-B-eDP-1
[434.225460] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[434.236481] Starting dynamic subtest: pipe-C-eDP-1
[434.256421] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[434.267240] Starting dynamic subtest: pipe-D-eDP-1
[434.286925] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[434.289157] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[436.468200] [087/133] (590s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[436.585040] Starting subtest: basic-flip-after-cursor-varying-size
[437.531348] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.946s)
[438.398642] [088/133] (588s left) syncobj_wait (wait-delayed-signal)
[438.451984] Starting subtest: wait-delayed-signal
[438.555107] Subtest wait-delayed-signal: SUCCESS (0.103s)
[438.610379] [089/133] (588s left) gem_create (hog-create)
[438.667464] Starting subtest: hog-create
[438.669798] Starting dynamic subtest: smem0
[472.386399] Dynamic subtest smem0: SUCCESS (33.719s)
[472.389201] Subtest hog-create: SUCCESS (33.721s)
[472.553563] [090/133] (554s left) kms_hdr (invalid-metadata-sizes)
[472.653166] Starting subtest: invalid-metadata-sizes
[472.659588] Subtest invalid-metadata-sizes: SKIP (0.000s)
[472.707113] [091/133] (554s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[472.809966] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[472.814363] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[472.865450] [092/133] (554s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[472.956563] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[472.965671] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[473.021699] [093/133] (554s left) kms_content_protection (atomic-hdcp14)
[473.164252] Starting subtest: atomic-hdcp14
[473.169364] Subtest atomic-hdcp14: SKIP (0.000s)
[473.263732] [094/133] (554s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[473.361271] Starting subtest: fbcpsr-tiling-y
[473.365468] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[473.430831] [095/133] (554s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[473.523952] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[478.481789] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.960s)
[479.604005] [096/133] (547s left) syncobj_timeline (signal)
[479.652756] Starting subtest: signal
[479.655093] Subtest signal: SUCCESS (0.000s)
[479.733717] [097/133] (547s left) syncobj_wait (wait-all-for-submit-complex)
[479.788481] Starting subtest: wait-all-for-submit-complex
[480.002550] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[480.061551] [098/133] (547s left) gem_mmap_offset (clear)
[480.112370] Starting subtest: clear
[480.114926] Starting dynamic subtest: smem0
[504.094238] Dynamic subtest smem0: SUCCESS (23.983s)
[504.097234] Subtest clear: SUCCESS (23.984s)
[504.196182] [099/133] (523s left) kms_prop_blob (invalid-get-prop)
[504.311559] Starting subtest: invalid-get-prop
[504.313814] Subtest invalid-get-prop: SUCCESS (0.000s)
[504.388451] [100/133] (523s left) gem_exec_whisper (basic-contexts-all)
[504.464084] Starting subtest: basic-contexts-all
[518.363967] Subtest basic-contexts-all: SUCCESS (13.897s)
[518.529856] [101/133] (509s left) kms_color (ctm-0-75)
[518.626586] Starting subtest: ctm-0-75
[518.628433] Starting dynamic subtest: pipe-A-eDP-1
[523.655099] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.031s)
[523.667497] Starting dynamic subtest: pipe-B-eDP-1
[529.384909] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.729s)
[529.398479] Starting dynamic subtest: pipe-C-eDP-1
[534.764091] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.380s)
[534.777405] Starting dynamic subtest: pipe-D-eDP-1
[540.104976] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.338s)
[540.106891] Subtest ctm-0-75: SUCCESS (21.481s)
[540.921529] [102/133] (486s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[541.030969] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[541.035216] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[541.102686] [103/133] (486s left) gem_exec_suspend (basic-s3-devices)
[541.176002] Starting subtest: basic-S3-devices
[541.178280] Starting dynamic subtest: smem
[552.380383] Dynamic subtest smem: SUCCESS (11.203s)
[552.383356] Subtest basic-S3-devices: SUCCESS (11.205s)
[552.585148] [104/133] (475s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[552.692524] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[552.696514] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[552.747456] [105/133] (475s left) kms_atomic (plane-overlay-legacy)
[552.852390] Starting subtest: plane-overlay-legacy
[552.854642] Starting dynamic subtest: pipe-A-eDP-1
[553.300364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[553.302613] Subtest plane-overlay-legacy: SUCCESS (0.450s)
[554.102603] [106/133] (473s left) gem_linear_blits (basic)
[554.289381] Starting subtest: basic
[554.298561] Subtest basic: SUCCESS (0.010s)
[554.421321] [107/133] (473s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[554.591668] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[556.098622] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.506s)
[556.969946] [108/133] (471s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[557.040363] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[557.044829] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[557.206823] [109/133] (470s left) tools_test (sysfs_l3_parity)
[557.252187] Starting subtest: sysfs_l3_parity
[557.337425] Subtest sysfs_l3_parity: SKIP (0.093s)
[557.377737] [110/133] (470s left) kms_chamelium_color (ctm-blue-to-red)
[557.479432] Subtest ctm-blue-to-red: SKIP (0.000s)
[557.531674] [111/133] (470s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[557.620111] Starting subtest: coverage-vs-premult-vs-constant
[557.908959] Starting dynamic subtest: pipe-A-eDP-1
[558.561213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.649s)
[558.575288] Starting dynamic subtest: pipe-D-eDP-1
[559.888566] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[559.890949] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.270s)
[560.729202] [112/133] (467s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[560.836316] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[560.840362] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[560.909917] [113/133] (467s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[561.022599] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[561.024836] Starting dynamic subtest: pipe-A-eDP-1
[561.120170] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[561.135399] Starting dynamic subtest: pipe-B-eDP-1
[562.316012] Dynamic subtest pipe-B-eDP-1: SKIP (1.192s)
[562.320802] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.296s)
[563.479777] [114/133] (464s left) i915_drm_fdinfo (virtual-busy-hang-all)
[563.518906] Starting subtest: virtual-busy-hang-all
[563.523720] Subtest virtual-busy-hang-all: SKIP (0.000s)
[563.565507] [115/133] (464s left) gem_exec_reloc (basic-gtt-read)
[563.619207] Subtest basic-gtt-read: SKIP (0.000s)
[563.689575] [116/133] (464s left) gem_softpin (allocator-fork)
[563.757119] Starting subtest: allocator-fork
[565.973082] Subtest allocator-fork: SUCCESS (2.214s)
[566.075290] [117/133] (462s left) gem_sync (basic-all)
[566.147655] Starting subtest: basic-all
[569.340230] Subtest basic-all: SUCCESS (3.198s)
[569.504858] [118/133] (459s left) gem_ctx_shared (q-out-order)
[569.582742] Starting subtest: Q-out-order
[569.584678] Starting dynamic subtest: rcs0
[569.751663] Dynamic subtest rcs0: SUCCESS (0.169s)
[569.767035] Starting dynamic subtest: vcs0
[569.876540] Dynamic subtest vcs0: SUCCESS (0.125s)
[569.894443] Starting dynamic subtest: vcs1
[569.988209] Dynamic subtest vcs1: SUCCESS (0.110s)
[570.009135] Starting dynamic subtest: vecs0
[570.104494] Dynamic subtest vecs0: SUCCESS (0.115s)
[570.125011] Starting dynamic subtest: ccs0
[570.235386] Dynamic subtest ccs0: SUCCESS (0.129s)
[570.237851] Subtest Q-out-order: SUCCESS (0.654s)
[571.450729] [119/133] (457s left) gem_exec_flush (basic-wb-set-default)
[571.516259] Starting subtest: basic-wb-set-default
[576.990195] Subtest basic-wb-set-default: SUCCESS (5.473s)
[577.163184] [120/133] (451s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[577.267086] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[578.312691] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.046s)
[578.405452] [121/133] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[578.503248] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[578.506694] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[578.580776] [122/133] (450s left) perf_pmu (most-busy-check-all)
[578.622138] Starting subtest: most-busy-check-all
[578.624111] Starting dynamic subtest: rcs0
[580.412382] Dynamic subtest rcs0: SUCCESS (1.787s)
[580.427355] Starting dynamic subtest: bcs0
[582.395190] Dynamic subtest bcs0: SUCCESS (1.978s)
[582.410488] Starting dynamic subtest: vcs0
[584.445556] Dynamic subtest vcs0: SUCCESS (2.046s)
[584.460319] Starting dynamic subtest: vcs1
[586.427513] Dynamic subtest vcs1: SUCCESS (1.979s)
[586.443631] Starting dynamic subtest: vecs0
[588.411674] Dynamic subtest vecs0: SUCCESS (1.980s)
[588.430605] Starting dynamic subtest: ccs0
[590.395326] Dynamic subtest ccs0: SUCCESS (1.980s)
[590.398216] Subtest most-busy-check-all: SUCCESS (11.770s)
[590.478751] [123/133] (438s left) gem_lmem_swapping (parallel-random)
[590.532685] Subtest parallel-random: SKIP (0.000s)
[590.586302] [124/133] (438s left) kms_invalid_mode (bad-htotal)
[590.691438] Starting subtest: bad-htotal
[590.693576] Starting dynamic subtest: pipe-A-eDP-1
[590.984054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[590.995452] Starting dynamic subtest: pipe-B-eDP-1
[590.997721] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[591.008968] Starting dynamic subtest: pipe-C-eDP-1
[591.010935] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[591.021897] Starting dynamic subtest: pipe-D-eDP-1
[591.023859] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[591.026270] Subtest bad-htotal: SUCCESS (0.298s)
[591.825969] [125/133] (437s left) syncobj_basic (test-valid-cycle)
[591.886056] Starting subtest: test-valid-cycle
[591.888433] Subtest test-valid-cycle: SUCCESS (0.000s)
[591.950621] [126/133] (436s left) kms_cursor_crc (cursor-random-512x170)
[592.241401] Starting subtest: cursor-random-512x170
[592.245674] Subtest cursor-random-512x170: SKIP (0.001s)
[592.352900] [127/133] (436s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[592.460687] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[592.464917] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[592.537398] [128/133] (436s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[592.630633] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[597.217126] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.589s)
[598.414784] [129/133] (430s left) api_intel_allocator (simple-allocator)
[598.472034] Starting subtest: simple-allocator
[598.474318] Starting dynamic subtest: basic
[598.476638] Dynamic subtest basic: SUCCESS (0.003s)
[598.492146] Starting dynamic subtest: parallel-one
[598.644546] Dynamic subtest parallel-one: SUCCESS (0.169s)
[598.658435] Starting dynamic subtest: print
[598.660720] Dynamic subtest print: SUCCESS (0.000s)
[598.671946] Starting dynamic subtest: reuse
[598.674378] Dynamic subtest reuse: SUCCESS (0.000s)
[598.686014] Starting dynamic subtest: reserve
[598.688378] Dynamic subtest reserve: SUCCESS (0.000s)
[598.700062] Starting dynamic subtest: fork-reopen-allocator
[598.702371] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[598.704714] Subtest simple-allocator: SUCCESS (0.188s)
[598.762803] [130/133] (430s left) kms_vblank (query-idle-hang)
[598.857688] Starting subtest: query-idle-hang
[598.859608] Starting dynamic subtest: pipe-A-eDP-1
[626.188194] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.325s)
[626.205007] Starting dynamic subtest: pipe-D-eDP-1
[641.143483] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.950s)
[641.145375] Subtest query-idle-hang: SUCCESS (42.279s)
[641.989853] [131/133] (387s left) i915_module_load (reload-no-display)
[642.030119] Starting subtest: reload-no-display
[647.485321] Subtest reload-no-display: SUCCESS (5.453s)
[647.516166] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[647.516938] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[647.520069] [132/133] (381s left) kms_fbcon_fbt (fbc)
[649.020062] Starting subtest: fbc
[655.520063] Subtest fbc: SUCCESS (6.500s)
[656.605393] [FACT kms_fbcon_fbt (fbc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[656.606701] [FACT kms_fbcon_fbt (fbc)] new: kernel.kmod_is_loaded.i915: true
[656.611166] [133/133] (372s left) dmabuf_sync_file (export-basic)
[656.664943] Starting subtest: export-basic
[656.667360] Subtest export-basic: SUCCESS (0.002s)
[656.704271] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_caching
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: sw_sync
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: prime_busy
results: parsing output: 8/ for test: i915_query
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_dither
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: syncobj_eventfd
results: parsing output: 15/ for test: gem_pwrite_snooped
results: parsing output: 16/ for test: kms_fbcon_fbt
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_feature_discovery
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_bad_reloc
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: gem_linear_blits
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_pm_dc
results: parsing output: 31/ for test: kms_chamelium_frames
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: gem_ctx_param
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_psr2_su
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_pipe_b_c_ivb
results: parsing output: 54/ for test: kms_atomic_interruptible
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_selftest
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_lease
results: parsing output: 64/ for test: i915_query
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_plane_multiple
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_vm_create
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: gem_pxp
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: gem_exec_parallel
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_create
results: parsing output: 89/ for test: kms_hdr
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: kms_content_protection
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_mmap_offset
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: gem_exec_whisper
results: parsing output: 100/ for test: kms_color
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_suspend
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: kms_atomic
results: parsing output: 105/ for test: gem_linear_blits
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: tools_test
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: kms_plane_alpha_blend
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: gem_sync
results: parsing output: 117/ for test: gem_ctx_shared
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: gem_lmem_swapping
results: parsing output: 123/ for test: kms_invalid_mode
results: parsing output: 124/ for test: syncobj_basic
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: i915_module_load
results: parsing output: 131/ for test: kms_fbcon_fbt
results: parsing output: 132/ for test: dmabuf_sync_file
Done.