[57.302122] Initializing watchdogs
[57.302174]   /dev/watchdog0
[57.316539] [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]
[57.320930] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.323173] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.326278] [001/134] (960s left) kms_content_protection (mei-interface)
[57.505756] Starting subtest: mei-interface
[57.510235] Subtest mei-interface: SKIP (0.001s)
[57.644987] [002/134] (960s left) kms_flip (modeset-vs-vblank-race)
[57.753422] Starting subtest: modeset-vs-vblank-race
[57.755645] Starting dynamic subtest: A-eDP1
[62.499068] Dynamic subtest A-eDP1: SUCCESS (4.752s)
[62.506227] Starting dynamic subtest: B-eDP1
[67.205305] Dynamic subtest B-eDP1: SUCCESS (4.709s)
[67.217853] Starting dynamic subtest: C-eDP1
[71.898420] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[71.907587] Starting dynamic subtest: D-eDP1
[76.506083] Dynamic subtest D-eDP1: SUCCESS (4.609s)
[76.510490] Subtest modeset-vs-vblank-race: SUCCESS (18.774s)
[77.790340] [003/134] (940s left) gem_ctx_isolation (nonpriv-switch)
[77.861183] Starting subtest: nonpriv-switch
[77.863564] Starting dynamic subtest: rcs0
[78.131365] Dynamic subtest rcs0: SUCCESS (0.270s)
[78.141059] Starting dynamic subtest: bcs0
[78.440775] Dynamic subtest bcs0: SUCCESS (0.309s)
[78.448718] Starting dynamic subtest: vcs0
[78.745293] Dynamic subtest vcs0: SUCCESS (0.305s)
[78.752444] Starting dynamic subtest: vcs1
[80.147829] Dynamic subtest vcs1: SUCCESS (1.402s)
[80.157857] Starting dynamic subtest: vecs0
[82.242804] Dynamic subtest vecs0: SUCCESS (2.095s)
[82.251759] Starting dynamic subtest: ccs0
[84.256809] Dynamic subtest ccs0: SUCCESS (2.014s)
[84.259312] Subtest nonpriv-switch: SUCCESS (6.398s)
[84.535334] [004/134] (933s left) gem_busy (close-race)
[84.597138] Starting subtest: close-race
[109.810440] Subtest close-race: SUCCESS (25.213s)
[110.244723] [FACT gem_busy (close-race)] new: kernel.kmod_is_loaded.vgem: true
[110.249609] [005/134] (907s left) gem_softpin (evict-prime)
[110.331951] Starting subtest: evict-prime
[110.334191] Starting dynamic subtest: rcs0
[111.536022] Dynamic subtest rcs0: SUCCESS (1.204s)
[111.547979] Starting dynamic subtest: bcs0
[112.680940] Dynamic subtest bcs0: SUCCESS (1.144s)
[112.691163] Starting dynamic subtest: vcs0
[113.902997] Dynamic subtest vcs0: SUCCESS (1.219s)
[113.913609] Starting dynamic subtest: vcs1
[115.891480] Dynamic subtest vcs1: SUCCESS (1.987s)
[115.902095] Starting dynamic subtest: vecs0
[117.885664] Dynamic subtest vecs0: SUCCESS (1.993s)
[117.896826] Starting dynamic subtest: ccs0
[119.016780] Dynamic subtest ccs0: SUCCESS (1.132s)
[119.027140] Starting dynamic subtest: all
[120.868445] Dynamic subtest all: SUCCESS (1.848s)
[120.870934] Subtest evict-prime: SUCCESS (10.534s)
[120.970875] [006/134] (897s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[123.051548] Starting subtest: dpms-mode-unset-lpsp
[127.102716] Subtest dpms-mode-unset-lpsp: SUCCESS (4.054s)
[127.491088] [007/134] (890s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[127.883232] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[128.681256] [008/134] (889s left) kms_atomic_interruptible (legacy-setmode)
[128.782648] Starting subtest: legacy-setmode
[128.784886] Starting dynamic subtest: pipe-A-eDP-1
[135.708512] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.923s)
[135.710857] Subtest legacy-setmode: SUCCESS (6.924s)
[136.583884] [009/134] (881s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[136.684394] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[136.688937] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[136.826719] [010/134] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[136.929582] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[136.933759] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[137.034702] [011/134] (881s left) dmabuf_sync_file (export-multiwait)
[137.087066] Starting subtest: export-multiwait
[137.089577] Subtest export-multiwait: SUCCESS (0.001s)
[137.158475] [012/134] (881s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[137.257844] Starting subtest: fbc-rgb101010-draw-render
[141.919965] Subtest fbc-rgb101010-draw-render: SUCCESS (4.666s)
[143.096113] [013/134] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[143.203153] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[147.472739] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.273s)
[148.671204] [014/134] (869s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[148.774871] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[148.801151] Starting dynamic subtest: pipe-A-plane-0
[148.805683] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[148.814761] Starting dynamic subtest: pipe-A-plane-3
[148.819322] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[148.826714] Starting dynamic subtest: pipe-A-plane-5
[148.831216] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[149.932689] Starting dynamic subtest: pipe-B-plane-0
[149.937082] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[149.944737] Starting dynamic subtest: pipe-B-plane-3
[149.949290] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[149.956636] Starting dynamic subtest: pipe-B-plane-5
[149.960950] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[150.237055] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (1.461s)
[151.128043] [015/134] (867s left) perf (gen12-mi-rpc)
[151.279183] Starting subtest: gen12-mi-rpc
[151.281479] Starting dynamic subtest: rcs0
[151.305061] Dynamic subtest rcs0: SUCCESS (0.025s)
[151.307024] Subtest gen12-mi-rpc: SUCCESS (0.025s)
[151.358941] [016/134] (867s left) kms_flip (flip-vs-absolute-wf_vblank)
[151.500820] Starting subtest: flip-vs-absolute-wf_vblank
[151.503166] Starting dynamic subtest: A-eDP1
[160.449058] Dynamic subtest A-eDP1: SUCCESS (8.950s)
[160.456363] Starting dynamic subtest: B-eDP1
[169.369956] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[169.379547] Starting dynamic subtest: C-eDP1
[178.290081] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[178.297981] Starting dynamic subtest: D-eDP1
[187.211487] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[187.216350] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.717s)
[188.449313] [017/134] (830s left) gem_softpin (evict-snoop-interruptible)
[188.517763] Starting subtest: evict-snoop-interruptible
[188.521967] Subtest evict-snoop-interruptible: SKIP (0.000s)
[188.641020] [018/134] (829s left) kms_flip (basic-flip-vs-modeset)
[188.737770] Starting subtest: basic-flip-vs-modeset
[188.739740] Starting dynamic subtest: A-eDP1
[191.313415] Dynamic subtest A-eDP1: SUCCESS (2.576s)
[191.321987] Starting dynamic subtest: B-eDP1
[193.488410] Dynamic subtest B-eDP1: SUCCESS (2.174s)
[193.497634] Starting dynamic subtest: C-eDP1
[195.540889] Dynamic subtest C-eDP1: SUCCESS (2.051s)
[195.549728] Starting dynamic subtest: D-eDP1
[197.725271] Dynamic subtest D-eDP1: SUCCESS (2.183s)
[197.727176] Subtest basic-flip-vs-modeset: SUCCESS (8.991s)
[198.520274] [019/134] (820s left) gem_fenced_exec_thrash (too-many-fences)
[198.583887] Subtest too-many-fences: SKIP (0.000s)
[198.668480] [020/134] (819s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[200.190245] Starting subtest: modeset-non-lpsp-stress-no-wait
[200.249023] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.060s)
[200.961728] [021/134] (817s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[201.062434] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[201.066637] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[201.162300] [022/134] (817s left) perf_pmu (pmu-read)
[201.215105] Starting subtest: pmu-read
[201.217434] Subtest pmu-read: SUCCESS (0.002s)
[201.375286] [023/134] (817s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[201.499772] Starting subtest: cursorA-vs-flipB-varying-size
[201.504172] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[201.667673] [024/134] (817s left) perf (i915-ref-count)
[201.790805] Starting subtest: i915-ref-count
[201.846894] Subtest i915-ref-count: SUCCESS (0.057s)
[201.900379] [025/134] (816s left) gem_userptr_blits (huge-split)
[201.969974] Starting subtest: huge-split
[201.974745] Subtest huge-split: SUCCESS (0.007s)
[202.113854] [026/134] (816s left) gem_ringfill (basic-all)
[207.895618] Starting subtest: basic-all
[209.073091] Subtest basic-all: SUCCESS (1.178s)
[209.222717] [027/134] (809s left) gem_mmap_gtt (basic-read-write)
[209.288216] Subtest basic-read-write: SKIP (0.000s)
[209.348949] [028/134] (809s left) sysfs_timeslice_duration (timeout)
[209.416784] Starting subtest: timeout
[209.419077] Starting dynamic subtest: vecs0
[218.898421] Dynamic subtest vecs0: SUCCESS (9.478s)
[218.909124] Starting dynamic subtest: ccs0
[220.197564] Dynamic subtest ccs0: SUCCESS (1.298s)
[220.207558] Starting dynamic subtest: vcs0
[229.920045] Dynamic subtest vcs0: SUCCESS (9.719s)
[229.930926] Starting dynamic subtest: bcs0
[230.573591] Dynamic subtest bcs0: SUCCESS (0.653s)
[230.583829] Starting dynamic subtest: rcs0
[231.981730] Dynamic subtest rcs0: SUCCESS (1.407s)
[231.996725] Starting dynamic subtest: vcs1
[241.954186] Dynamic subtest vcs1: SUCCESS (9.969s)
[241.956580] Subtest timeout: SUCCESS (32.534s)
[242.040701] [029/134] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[242.158220] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[242.162135] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[242.289721] [030/134] (776s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[242.362067] Subtest tiled-to-untiled: SKIP (0.000s)
[242.444935] [031/134] (776s left) prime_vgem (busy)
[242.533495] Starting subtest: busy
[242.535812] Starting dynamic subtest: rcs0
[242.587049] Dynamic subtest rcs0: SUCCESS (0.053s)
[242.594820] Starting dynamic subtest: bcs0
[242.658707] Dynamic subtest bcs0: SUCCESS (0.071s)
[242.666568] Starting dynamic subtest: vcs0
[242.703381] Dynamic subtest vcs0: SUCCESS (0.044s)
[242.711498] Starting dynamic subtest: vcs1
[242.749399] Dynamic subtest vcs1: SUCCESS (0.045s)
[242.757153] Starting dynamic subtest: vecs0
[242.797238] Dynamic subtest vecs0: SUCCESS (0.047s)
[242.805072] Starting dynamic subtest: ccs0
[242.844313] Dynamic subtest ccs0: SUCCESS (0.046s)
[242.846420] Subtest busy: SUCCESS (0.311s)
[243.005969] [032/134] (776s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[248.014786] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[248.019684] Starting dynamic subtest: pipe-A-eDP-1
[254.885900] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.865s)
[254.894800] Starting dynamic subtest: pipe-B-eDP-1
[261.923501] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.035s)
[261.925487] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.906s)
[262.801218] [033/134] (756s left) gen9_exec_parse (unaligned-access)
[262.877209] Subtest unaligned-access: SKIP (0.000s)
[262.931107] [034/134] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[263.039700] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[270.451564] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.416s)
[270.623868] [035/134] (748s left) api_intel_bb (reset-flags)
[270.686193] Starting subtest: reset-flags
[270.690803] Subtest reset-flags: SUCCESS (0.008s)
[270.840229] [036/134] (748s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[270.971230] Starting subtest: basic-flip-after-cursor-varying-size
[271.902678] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.930s)
[272.749306] [037/134] (746s left) kms_plane (plane-panning-bottom-right-suspend)
[272.846310] Starting subtest: plane-panning-bottom-right-suspend
[272.848156] Starting dynamic subtest: pipe-A
[290.533365] Dynamic subtest pipe-A: SUCCESS (3.710s)
[290.542994] Starting dynamic subtest: pipe-B
[309.509901] Dynamic subtest pipe-B: SUCCESS (3.501s)
[309.512045] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.214s)
[310.339118] [038/134] (709s left) gem_render_copy (y-tiled-ccs-to-linear)
[310.408370] Starting subtest: y-tiled-ccs-to-linear
[310.412997] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[310.601670] [039/134] (708s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[310.706032] Starting subtest: y-tiled-32bpp-rotate-0
[310.710221] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[310.846289] [040/134] (708s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[310.970968] Starting subtest: flip-vs-cursor-busy-crc-atomic
[311.781675] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s)
[312.633849] [041/134] (706s left) gem_eio (in-flight-internal-immediate)
[312.861135] Starting subtest: in-flight-internal-immediate
[314.416088] Subtest in-flight-internal-immediate: SUCCESS (1.558s)
[314.622439] [042/134] (704s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[314.737517] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[321.776509] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.056s)
[321.911339] [043/134] (697s left) gem_exec_params (readonly)
[321.975584] Starting subtest: readonly
[321.977871] Subtest readonly: SUCCESS (0.002s)
[322.116893] [044/134] (697s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[322.172585] Starting subtest: invalid-single-wait-all-unsubmitted
[322.174838] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[322.332769] [045/134] (697s left) kms_busy (extended-pageflip-hang-newfb)
[322.449399] Starting subtest: extended-pageflip-hang-newfb
[322.451655] Starting dynamic subtest: pipe-A
[349.131407] Dynamic subtest pipe-A: SUCCESS (26.692s)
[349.140810] Starting dynamic subtest: pipe-D
[374.139450] Dynamic subtest pipe-D: SUCCESS (25.006s)
[374.141915] Subtest extended-pageflip-hang-newfb: SUCCESS (51.703s)
[374.976310] [046/134] (644s left) kms_getfb (getfb2-handle-zero)
[375.081199] Starting subtest: getfb2-handle-zero
[375.083492] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[375.191529] [047/134] (644s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[375.299155] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[375.671038] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[378.420547] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.748s)
[378.431752] Starting dynamic subtest: pipe-A-eDP-1-4
[380.594843] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[380.606120] Starting dynamic subtest: pipe-A-eDP-1-4
[382.603824] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[382.612691] Starting dynamic subtest: pipe-A-eDP-1-x
[384.782642] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[385.158231] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[387.943574] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.794s)
[387.952978] Starting dynamic subtest: pipe-B-eDP-1-4
[390.139850] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.195s)
[390.148881] Starting dynamic subtest: pipe-B-eDP-1-4
[392.149976] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[392.172288] Starting dynamic subtest: pipe-B-eDP-1-x
[394.349751] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.198s)
[394.743456] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[397.473011] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.742s)
[397.485048] Starting dynamic subtest: pipe-C-eDP-1-4
[399.647384] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[399.656627] Starting dynamic subtest: pipe-C-eDP-1-4
[401.656446] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.007s)
[401.668318] Starting dynamic subtest: pipe-C-eDP-1-x
[403.846147] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s)
[404.212410] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[406.993994] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.788s)
[407.003025] Starting dynamic subtest: pipe-D-eDP-1-4
[409.170988] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[409.182810] Starting dynamic subtest: pipe-D-eDP-1-4
[411.180775] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[411.190325] Starting dynamic subtest: pipe-D-eDP-1-x
[413.372389] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[413.375081] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.079s)
[414.594402] [048/134] (605s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[414.700658] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[414.702912] Starting dynamic subtest: pipe-A-eDP-1
[414.724602] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[414.735164] Starting dynamic subtest: pipe-B-eDP-1
[414.756176] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[414.764796] Starting dynamic subtest: pipe-C-eDP-1
[414.785433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[414.794860] Starting dynamic subtest: pipe-D-eDP-1
[414.816174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[414.820486] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[416.891698] [049/134] (602s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[417.002404] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[417.006327] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[417.120581] [050/134] (602s left) gem_ctx_param (basic)
[417.181527] Starting subtest: basic
[417.183846] Subtest basic: SUCCESS (0.001s)
[417.313325] [051/134] (602s left) gem_exec_fence (syncobj-channel)
[417.757442] Starting subtest: syncobj-channel
[418.776589] Subtest syncobj-channel: SUCCESS (1.015s)
[419.489048] [052/134] (600s left) kms_properties (colorop-properties-atomic)
[419.583465] Starting subtest: colorop-properties-atomic
[419.585328] Starting dynamic subtest: pipe-A-eDP-1
[419.977683] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.394s)
[419.987446] Starting dynamic subtest: pipe-B-eDP-1
[421.053364] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s)
[421.062863] Starting dynamic subtest: pipe-C-eDP-1
[422.096904] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.040s)
[422.116266] Starting dynamic subtest: pipe-D-eDP-1
[423.123462] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.024s)
[423.125458] Subtest colorop-properties-atomic: SUCCESS (3.539s)
[423.943379] [053/134] (596s left) gem_exec_params (invalid-ring)
[424.014749] Starting subtest: invalid-ring
[424.017045] Subtest invalid-ring: SUCCESS (0.000s)
[424.141126] [054/134] (595s left) gem_ctx_engines (execute-oneforall)
[424.204563] Starting subtest: execute-oneforall
[424.897637] Subtest execute-oneforall: SUCCESS (0.691s)
[426.512816] [055/134] (593s left) gem_exec_balancer (parallel-contexts)
[426.777627] Starting subtest: parallel-contexts
[431.369228] Subtest parallel-contexts: SUCCESS (4.591s)
[432.570066] [056/134] (587s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[432.622528] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[432.624759] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[432.763431] [057/134] (587s left) kms_setmode (invalid-clone-exclusive-crtc)
[432.821896] Starting subtest: invalid-clone-exclusive-crtc
[432.828349] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[432.931287] [058/134] (587s left) kms_atomic (atomic-plane-damage)
[433.023610] Starting subtest: atomic-plane-damage
[433.073529] Starting dynamic subtest: pipe-A-eDP-1
[433.619841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.547s)
[433.622150] Subtest atomic-plane-damage: SUCCESS (0.598s)
[434.471654] [059/134] (585s left) gem_exec_async (concurrent-writes)
[434.536801] Starting subtest: concurrent-writes
[434.539027] Starting dynamic subtest: rcs0
[434.553339] Dynamic subtest rcs0: SUCCESS (0.016s)
[434.564946] Starting dynamic subtest: bcs0
[434.567210] Dynamic subtest bcs0: SUCCESS (0.005s)
[434.576418] Starting dynamic subtest: vcs0
[434.578702] Dynamic subtest vcs0: SUCCESS (0.005s)
[434.587383] Starting dynamic subtest: vcs1
[434.589640] Dynamic subtest vcs1: SUCCESS (0.006s)
[434.598219] Starting dynamic subtest: vecs0
[434.600405] Dynamic subtest vecs0: SUCCESS (0.006s)
[434.610079] Starting dynamic subtest: ccs0
[434.612283] Dynamic subtest ccs0: SUCCESS (0.005s)
[434.614463] Subtest concurrent-writes: SUCCESS (0.047s)
[434.836524] [060/134] (585s left) api_intel_bb (blit-reloc-keep-cache)
[434.895609] Starting subtest: blit-reloc-keep-cache
[434.900020] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[435.053028] [061/134] (585s left) kms_atomic_interruptible (legacy-pageflip)
[435.162479] Starting subtest: legacy-pageflip
[435.164789] Starting dynamic subtest: pipe-A-eDP-1
[442.600398] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.438s)
[442.602727] Subtest legacy-pageflip: SUCCESS (7.439s)
[443.440718] [062/134] (576s left) kms_flip (bo-too-big-interruptible)
[443.552313] Starting subtest: bo-too-big-interruptible
[443.554220] Starting dynamic subtest: A-eDP1
[444.882977] Dynamic subtest A-eDP1: SUCCESS (1.329s)
[444.892460] Starting dynamic subtest: B-eDP1
[446.119389] Dynamic subtest B-eDP1: SUCCESS (1.235s)
[446.131350] Starting dynamic subtest: C-eDP1
[447.381421] Dynamic subtest C-eDP1: SUCCESS (1.260s)
[447.393087] Starting dynamic subtest: D-eDP1
[448.704166] Dynamic subtest D-eDP1: SUCCESS (1.322s)
[448.706530] Subtest bo-too-big-interruptible: SUCCESS (5.155s)
[449.918948] [063/134] (570s left) gem_ctx_persistence (file)
[449.990653] Starting subtest: file
[450.131260] Subtest file: SUCCESS (0.141s)
[450.279342] [064/134] (570s left) syncobj_basic (bad-flags-handle-to-fd)
[450.345838] Starting subtest: bad-flags-handle-to-fd
[450.348011] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[450.466668] [065/134] (570s left) kms_universal_plane (universal-plane-functional)
[450.560518] Starting subtest: universal-plane-functional
[450.562843] Starting dynamic subtest: pipe-A-eDP-1
[454.507801] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.946s)
[454.520447] Starting dynamic subtest: pipe-B-eDP-1
[459.115991] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.607s)
[459.125878] Starting dynamic subtest: pipe-C-eDP-1
[463.475036] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.358s)
[463.485196] Starting dynamic subtest: pipe-D-eDP-1
[467.846826] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.370s)
[467.848755] Subtest universal-plane-functional: SUCCESS (17.288s)
[468.720416] [066/134] (551s left) kms_cursor_edge_walk (64x64-top-bottom)
[468.823513] Starting subtest: 64x64-top-bottom
[468.825805] Starting dynamic subtest: pipe-A-eDP-1
[472.269492] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[472.279162] Starting dynamic subtest: pipe-D-eDP-1
[475.385630] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[475.387874] Subtest 64x64-top-bottom: SUCCESS (6.563s)
[476.217912] [067/134] (544s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[481.300527] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[481.302880] Starting dynamic subtest: pipe-A-eDP-1
[482.107496] Dynamic subtest pipe-A-eDP-1: SKIP (0.804s)
[482.117696] Starting dynamic subtest: pipe-B-eDP-1
[483.238401] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[483.242852] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.939s)
[484.434077] [068/134] (536s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[484.546727] Starting subtest: yf-tiled-8bpp-rotate-180
[484.550737] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[484.665088] [069/134] (536s left) gem_exec_schedule (pi-shared-iova)
[484.857747] Starting subtest: pi-shared-iova
[484.860014] Starting dynamic subtest: rcs0
[484.924503] Dynamic subtest rcs0: SUCCESS (0.069s)
[484.936660] Starting dynamic subtest: vcs0
[484.974953] Dynamic subtest vcs0: SUCCESS (0.050s)
[484.987483] Starting dynamic subtest: vcs1
[485.029143] Dynamic subtest vcs1: SUCCESS (0.053s)
[485.040839] Starting dynamic subtest: vecs0
[485.090129] Dynamic subtest vecs0: SUCCESS (0.060s)
[485.102216] Starting dynamic subtest: ccs0
[485.149894] Dynamic subtest ccs0: SUCCESS (0.059s)
[485.152408] Subtest pi-shared-iova: SUCCESS (0.295s)
[486.510494] [070/134] (534s left) kms_psr (psr2-primary-blt)
[486.623679] Starting subtest: psr2-primary-blt
[486.625935] Starting dynamic subtest: eDP-1
[488.302744] Dynamic subtest eDP-1: SUCCESS (1.679s)
[488.304888] Subtest psr2-primary-blt: SUCCESS (1.681s)
[489.180235] [071/134] (531s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[489.277887] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[489.280237] Starting dynamic subtest: pipe-A-eDP-1
[489.302689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.314795] Starting dynamic subtest: pipe-B-eDP-1
[489.337045] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.348767] Starting dynamic subtest: pipe-C-eDP-1
[489.371215] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.382346] Starting dynamic subtest: pipe-D-eDP-1
[489.403842] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.407627] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[491.554290] [072/134] (529s left) prime_mmap (test_forked)
[491.620808] Starting subtest: test_forked
[491.622805] Starting dynamic subtest: test_forked-smem
[491.664222] Dynamic subtest test_forked-smem: SUCCESS (0.043s)
[491.666714] Subtest test_forked: SUCCESS (0.044s)
[491.791750] [073/134] (529s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[491.887893] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[491.915954] Starting dynamic subtest: pipe-A-plane-0
[491.920412] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[491.930328] Starting dynamic subtest: pipe-A-plane-3
[491.935580] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[491.944655] Starting dynamic subtest: pipe-A-plane-5
[491.949088] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[493.023136] Starting dynamic subtest: pipe-B-plane-0
[493.027840] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[493.039608] Starting dynamic subtest: pipe-B-plane-3
[493.044342] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[493.053786] Starting dynamic subtest: pipe-B-plane-5
[493.058088] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[493.341768] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (1.451s)
[494.221864] [074/134] (526s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[494.339864] Starting subtest: 2x-cursor-vs-flip-atomic
[494.344412] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[494.497350] [075/134] (526s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[494.556993] Starting subtest: multi-wait-available-unsubmitted-signaled
[494.559231] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[494.663313] [076/134] (526s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[495.052471] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[495.901037] [077/134] (525s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[496.028941] Starting subtest: 4-tiled-8bpp-rotate-180
[497.263669] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.235s)
[497.410471] [078/134] (523s left) kms_cursor_crc (cursor-random-512x170)
[497.717680] Starting subtest: cursor-random-512x170
[497.721142] Subtest cursor-random-512x170: SKIP (0.001s)
[497.876164] [079/134] (523s left) kms_plane_scaling (planes-upscale-20x20)
[497.980179] Starting subtest: planes-upscale-20x20
[497.982066] Starting dynamic subtest: pipe-A
[498.040135] Dynamic subtest pipe-A: SUCCESS (0.062s)
[498.051649] Starting dynamic subtest: pipe-B
[499.144174] Dynamic subtest pipe-B: SUCCESS (1.103s)
[499.155586] Starting dynamic subtest: pipe-C
[500.262706] Dynamic subtest pipe-C: SUCCESS (1.117s)
[500.272942] Starting dynamic subtest: pipe-D
[501.393668] Dynamic subtest pipe-D: SUCCESS (1.130s)
[501.395951] Subtest planes-upscale-20x20: SUCCESS (3.417s)
[502.539465] [080/134] (518s left) kms_vblank (wait-busy-hang)
[502.643304] Starting subtest: wait-busy-hang
[502.645508] Starting dynamic subtest: pipe-A-eDP-1
[529.128623] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.486s)
[529.143178] Starting dynamic subtest: pipe-D-eDP-1
[554.172676] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.036s)
[554.174847] Subtest wait-busy-hang: SUCCESS (51.527s)
[555.026799] [081/134] (466s left) kms_psr (fbc-psr-cursor-blt)
[555.124522] Starting subtest: fbc-psr-cursor-blt
[555.126863] Starting dynamic subtest: eDP-1
[555.130950] Dynamic subtest eDP-1: SKIP (0.000s)
[555.135098] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[555.234565] [082/134] (466s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[555.358844] Starting subtest: x-tiled-64bpp-rotate-180
[556.917337] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.557s)
[557.154289] [083/134] (464s left) syncobj_timeline (single-wait-for-submit-signaled)
[557.230130] Starting subtest: single-wait-for-submit-signaled
[557.232611] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[557.357029] [084/134] (464s left) gem_exec_balancer (bonded-sync)
[557.433091] Starting subtest: bonded-sync
[557.437379] Subtest bonded-sync: SKIP (0.000s)
[557.748582] [085/134] (463s left) gem_exec_schedule (thriceslice)
[557.828803] Starting subtest: thriceslice
[557.831134] Starting dynamic subtest: rcs0
[557.846502] Dynamic subtest rcs0: SUCCESS (0.028s)
[557.857758] Starting dynamic subtest: bcs0
[557.874710] Dynamic subtest bcs0: SUCCESS (0.027s)
[557.883998] Starting dynamic subtest: vcs0
[557.926122] Dynamic subtest vcs0: SUCCESS (0.050s)
[557.937070] Starting dynamic subtest: vcs1
[557.974653] Dynamic subtest vcs1: SUCCESS (0.048s)
[557.986564] Starting dynamic subtest: vecs0
[558.006079] Dynamic subtest vecs0: SUCCESS (0.029s)
[558.015128] Starting dynamic subtest: ccs0
[558.058913] Dynamic subtest ccs0: SUCCESS (0.051s)
[558.061330] Subtest thriceslice: SUCCESS (0.243s)
[558.370396] [086/134] (463s left) i915_pm_rps (fence-order)
[558.439648] Starting subtest: fence-order
[561.314262] Subtest fence-order: SUCCESS (2.873s)
[561.465178] [087/134] (460s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[561.563435] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[561.567449] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[561.646833] [088/134] (459s left) gem_eio (wait-wedge-immediate)
[561.861922] Starting subtest: wait-wedge-immediate
[563.445700] Subtest wait-wedge-immediate: SUCCESS (1.586s)
[563.610544] [089/134] (457s left) kms_draw_crc (draw-method-pwrite)
[563.711774] Starting subtest: draw-method-pwrite
[563.713669] Starting dynamic subtest: xrgb8888-untiled
[564.298367] Dynamic subtest xrgb8888-untiled: SUCCESS (0.589s)
[564.308099] Starting dynamic subtest: rgb565-untiled
[564.732071] Dynamic subtest rgb565-untiled: SUCCESS (0.433s)
[564.744250] Starting dynamic subtest: xrgb2101010-untiled
[565.277966] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[565.287589] Starting dynamic subtest: xbgr16161616f-untiled
[566.043519] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.765s)
[566.057356] Starting dynamic subtest: xrgb8888-xtiled
[567.799244] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.754s)
[567.809203] Starting dynamic subtest: rgb565-xtiled
[568.865988] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s)
[568.877837] Starting dynamic subtest: xrgb2101010-xtiled
[570.621687] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.755s)
[570.632646] Starting dynamic subtest: xbgr16161616f-xtiled
[574.167311] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.544s)
[574.177550] Starting dynamic subtest: xrgb8888-4tiled
[575.267234] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[575.276809] Starting dynamic subtest: rgb565-4tiled
[575.822979] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s)
[575.832961] Starting dynamic subtest: xrgb2101010-4tiled
[576.889850] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.065s)
[576.899696] Starting dynamic subtest: xbgr16161616f-4tiled
[579.867736] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.977s)
[579.870085] Subtest draw-method-pwrite: SUCCESS (16.156s)
[580.006161] [090/134] (441s left) kms_plane_alpha_blend (coverage-7efc)
[580.107366] Starting subtest: coverage-7efc
[580.384485] Starting dynamic subtest: pipe-A-eDP-1
[580.955256] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[580.985539] Starting dynamic subtest: pipe-D-eDP-1
[582.285933] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[582.288236] Subtest coverage-7efc: SUCCESS (2.178s)
[583.112003] [091/134] (438s left) gem_mmap_offset (clear-via-pagefault)
[583.174510] Starting subtest: clear-via-pagefault
[583.176456] Starting dynamic subtest: smem0
[617.774256] Dynamic subtest smem0: SUCCESS (34.592s)
[617.776755] Subtest clear-via-pagefault: SUCCESS (34.595s)
[617.909771] [092/134] (403s left) gem_ccs (ctrl-surf-copy)
[617.972593] Starting subtest: ctrl-surf-copy
[617.977786] Subtest ctrl-surf-copy: SKIP (0.000s)
[618.105020] [093/134] (403s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[618.200843] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[618.204660] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.311991] [094/134] (403s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[618.404643] Starting subtest: bad-rotation-90-yf-tiled-ccs
[618.406859] Starting dynamic subtest: pipe-A-eDP-1
[618.428635] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[618.445467] Starting dynamic subtest: pipe-B-eDP-1
[618.467350] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[618.478820] Starting dynamic subtest: pipe-C-eDP-1
[618.499542] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[618.508759] Starting dynamic subtest: pipe-D-eDP-1
[618.530777] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[618.535136] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[620.659056] [095/134] (401s left) kms_lease (lease-unleased-connector)
[620.753764] Starting subtest: lease-unleased-connector
[620.756104] Starting dynamic subtest: pipe-A-eDP-1
[620.761791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[620.774465] Starting dynamic subtest: pipe-B-eDP-1
[620.776688] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s)
[620.791845] Starting dynamic subtest: pipe-C-eDP-1
[620.793992] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.008s)
[620.803157] Starting dynamic subtest: pipe-D-eDP-1
[620.805332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s)
[620.807531] Subtest lease-unleased-connector: SUCCESS (0.037s)
[620.917824] [096/134] (400s left) gem_lmem_swapping (heavy-verify-random-ccs)
[620.959088] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[621.003501] [097/134] (400s left) vgem_basic (create)
[621.049788] Starting subtest: create
[621.051642] Subtest create: SUCCESS (0.000s)
[621.130104] [098/134] (400s left) gem_mmap_gtt (cpuset-big-copy)
[621.194819] Subtest cpuset-big-copy: SKIP (0.000s)
[621.263316] [099/134] (400s left) i915_pm_freq_api (freq-reset-multiple)
[621.335007] Starting subtest: freq-reset-multiple
[621.337164] Starting dynamic subtest: gt0
[630.427646] Dynamic subtest gt0: SUCCESS (9.094s)
[630.436731] Starting dynamic subtest: gt1
[638.990453] Dynamic subtest gt1: SUCCESS (8.545s)
[638.995256] Subtest freq-reset-multiple: SUCCESS (17.641s)
[639.069995] [100/134] (382s left) kms_invalid_mode (int-max-clock)
[639.178723] Starting subtest: int-max-clock
[639.181029] Starting dynamic subtest: pipe-A-eDP-1
[639.462125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[639.472644] Starting dynamic subtest: pipe-B-eDP-1
[639.474842] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[639.484123] Starting dynamic subtest: pipe-C-eDP-1
[639.486031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[639.495169] Starting dynamic subtest: pipe-D-eDP-1
[639.497094] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[639.498996] Subtest int-max-clock: SUCCESS (0.290s)
[640.300299] [101/134] (381s left) kms_psr (psr-sprite-render)
[640.395340] Starting subtest: psr-sprite-render
[640.397743] Starting dynamic subtest: eDP-1
[642.103912] Dynamic subtest eDP-1: SUCCESS (1.708s)
[642.106277] Subtest psr-sprite-render: SUCCESS (1.709s)
[642.952808] [102/134] (379s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[643.056888] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[643.059198] Starting dynamic subtest: pipe-A-eDP-1
[643.083628] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.095280] Starting dynamic subtest: pipe-B-eDP-1
[643.118108] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.127654] Starting dynamic subtest: pipe-C-eDP-1
[643.150832] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.160159] Starting dynamic subtest: pipe-D-eDP-1
[643.184194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.188236] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[645.324457] [103/134] (376s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[645.427916] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[646.429331] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s)
[646.598713] [104/134] (375s left) i915_selftest (perf)
[650.128545] Starting subtest: perf
[650.131183] Starting dynamic subtest: engine_cs
[654.713969] Dynamic subtest engine_cs: SUCCESS (4.584s)
[654.724240] Starting dynamic subtest: request
[662.129110] Dynamic subtest request: SUCCESS (7.414s)
[662.139290] Starting dynamic subtest: migrate
[666.626924] Dynamic subtest migrate: SUCCESS (4.496s)
[666.637101] Starting dynamic subtest: region
[672.641258] Dynamic subtest region: SUCCESS (6.013s)
[672.643728] Subtest perf: SUCCESS (22.516s)
[672.672466] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[672.673206] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[672.676718] [105/134] (349s left) kms_cursor_crc (cursor-onscreen-512x512)
[674.492143] Starting subtest: cursor-onscreen-512x512
[674.496746] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[674.673302] [FACT kms_cursor_crc (cursor-onscreen-512x512)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[674.674721] [FACT kms_cursor_crc (cursor-onscreen-512x512)] new: kernel.kmod_is_loaded.i915: true
[674.678920] [106/134] (347s left) sw_sync (sync_merge_invalid)
[674.719358] Starting subtest: sync_merge_invalid
[674.748712] Subtest sync_merge_invalid: SUCCESS (0.032s)
[674.842630] [107/134] (347s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[674.908964] Starting subtest: x-tiled-to-vebox-y-tiled
[674.913457] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[675.113428] [108/134] (347s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[675.225414] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[676.281708] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.057s)
[676.435512] [109/134] (346s left) core_setmaster_vs_auth
[676.613707] [110/134] (345s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[676.706596] Starting subtest: fbc-psr2-primary-mmap-cpu
[676.708463] Starting dynamic subtest: eDP-1
[676.711827] Dynamic subtest eDP-1: SKIP (0.000s)
[676.715231] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[676.804217] [111/134] (345s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[676.907547] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[684.434541] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.529s)
[684.617776] [112/134] (337s left) kms_cursor_legacy (single-move)
[684.737743] Starting subtest: single-move
[684.739963] Starting dynamic subtest: pipe-A
[690.122175] Dynamic subtest pipe-A: SUCCESS (5.380s)
[690.133236] Starting dynamic subtest: pipe-B
[695.504110] Dynamic subtest pipe-B: SUCCESS (5.380s)
[695.514652] Starting dynamic subtest: pipe-C
[700.885109] Dynamic subtest pipe-C: SUCCESS (5.379s)
[700.895628] Starting dynamic subtest: pipe-D
[706.266321] Dynamic subtest pipe-D: SUCCESS (5.379s)
[706.277322] Starting dynamic subtest: all-pipes
[711.655359] Dynamic subtest all-pipes: SUCCESS (5.387s)
[711.657879] Subtest single-move: SUCCESS (26.919s)
[711.810927] [113/134] (310s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[711.921227] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[711.925287] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[712.043872] [114/134] (310s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[712.135751] Starting subtest: fbcpsr-abgr161616f-draw-render
[712.139691] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[712.242528] [115/134] (310s left) kms_color_pipeline (plane-lut1d)
[712.351922] Starting subtest: plane-lut1d
[712.365023] Starting dynamic subtest: pipe-A-eDP-1
[713.007140] Dynamic subtest pipe-A-eDP-1: FAIL (0.329s)
[713.748498] Starting dynamic subtest: pipe-B-eDP-1
[714.574772] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s)
[715.176623] Starting dynamic subtest: pipe-C-eDP-1
[716.052669] Dynamic subtest pipe-C-eDP-1: FAIL (0.302s)
[716.508249] Starting dynamic subtest: pipe-D-eDP-1
[717.349431] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[717.351792] Subtest plane-lut1d: FAIL (4.709s)
[717.898829] [116/134] (304s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[717.974067] Starting subtest: invalid-bsd1-flag-on-vebox
[717.976382] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[718.099537] [117/134] (304s left) syncobj_wait (wait-any-complex)
[718.156155] Starting subtest: wait-any-complex
[718.215907] Subtest wait-any-complex: SUCCESS (0.061s)
[718.306817] [118/134] (304s left) gem_mmap_wc (pf-nonblock)
[718.367135] Subtest pf-nonblock: SKIP (0.000s)
[718.435099] [119/134] (304s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[718.529863] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[722.490419] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.965s)
[723.715083] [120/134] (299s left) gem_exec_store (dword)
[723.819228] Starting subtest: dword
[723.821591] Starting dynamic subtest: rcs0
[723.995103] Dynamic subtest rcs0: SUCCESS (0.177s)
[724.007434] Starting dynamic subtest: bcs0
[724.123705] Dynamic subtest bcs0: SUCCESS (0.126s)
[724.135347] Starting dynamic subtest: vcs0
[724.167406] Dynamic subtest vcs0: SUCCESS (0.041s)
[724.184068] Starting dynamic subtest: vcs1
[724.210734] Dynamic subtest vcs1: SUCCESS (0.041s)
[724.225324] Starting dynamic subtest: vecs0
[724.255748] Dynamic subtest vecs0: SUCCESS (0.042s)
[724.268348] Starting dynamic subtest: ccs0
[724.299935] Dynamic subtest ccs0: SUCCESS (0.042s)
[724.302280] Subtest dword: SUCCESS (0.485s)
[724.500834] [121/134] (298s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[724.606279] Starting subtest: primary-yf-tiled-reflect-x-270
[724.610485] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[724.706395] [122/134] (298s left) testdisplay
[725.103728] [123/134] (297s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[725.208860] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[725.213122] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[725.345469] [124/134] (297s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[725.451835] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[729.962585] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.513s)
[731.128409] [125/134] (291s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[731.235663] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[731.237881] Starting dynamic subtest: pipe-A-default-mode
[732.369794] Dynamic subtest pipe-A-default-mode: SKIP (1.132s)
[732.373670] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.134s)
[732.537546] [126/134] (290s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[732.647168] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[732.651522] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[732.775562] [127/134] (290s left) syncobj_wait (single-wait-all-for-submit-signaled)
[732.828779] Starting subtest: single-wait-all-for-submit-signaled
[732.830643] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[732.943135] [128/134] (290s left) kms_psr (pr-primary-blt)
[733.040790] Starting subtest: pr-primary-blt
[733.044753] Subtest pr-primary-blt: SKIP (0.000s)
[733.134401] [129/134] (290s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[733.228901] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[740.167304] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.941s)
[740.351677] [130/134] (282s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[740.460433] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[740.462649] Starting dynamic subtest: pipe-A-eDP-1
[740.482648] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[740.493043] Starting dynamic subtest: pipe-B-eDP-1
[740.512628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[740.520798] Starting dynamic subtest: pipe-C-eDP-1
[740.539765] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[740.547944] Starting dynamic subtest: pipe-D-eDP-1
[740.566919] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[740.568809] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.016s)
[742.754486] [131/134] (280s left) gem_eio (wait-10ms)
[742.983137] Starting subtest: wait-10ms
[743.330917] Subtest wait-10ms: SUCCESS (0.348s)
[743.502838] [132/134] (279s left) gem_exec_params (rel-constants-invalid-ring)
[743.561371] Starting subtest: rel-constants-invalid-ring
[743.563224] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[743.689625] [133/134] (279s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[743.749211] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[743.856828] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[743.947819] [134/134] (279s left) gen9_exec_parse (bb-start-far)
[744.013314] Subtest bb-start-far: SKIP (0.000s)
[744.077808] Closing watchdogs
results: parsing output: 0/ for test: kms_content_protection
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: gem_ctx_isolation
results: parsing output: 3/ for test: gem_busy
results: parsing output: 4/ for test: gem_softpin
results: parsing output: 5/ for test: kms_pm_rpm
results: parsing output: 6/ for test: kms_chamelium_edid
results: parsing output: 7/ for test: kms_atomic_interruptible
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: dmabuf_sync_file
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_fenced_exec_thrash
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: gem_ringfill
results: parsing output: 26/ for test: gem_mmap_gtt
results: parsing output: 27/ for test: sysfs_timeslice_duration
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_set_tiling_vs_blt
results: parsing output: 30/ for test: prime_vgem
results: parsing output: 31/ for test: kms_psr2_sf
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_render_copy
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_params
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_ctx_param
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_properties
results: parsing output: 52/ for test: gem_exec_params
results: parsing output: 53/ for test: gem_ctx_engines
results: parsing output: 54/ for test: gem_exec_balancer
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: kms_setmode
results: parsing output: 57/ for test: kms_atomic
results: parsing output: 58/ for test: gem_exec_async
results: parsing output: 59/ for test: api_intel_bb
results: parsing output: 60/ for test: kms_atomic_interruptible
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gem_ctx_persistence
results: parsing output: 63/ for test: syncobj_basic
results: parsing output: 64/ for test: kms_universal_plane
results: parsing output: 65/ for test: kms_cursor_edge_walk
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_vblank
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: i915_pm_rps
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: kms_plane_alpha_blend
results: parsing output: 90/ for test: gem_mmap_offset
results: parsing output: 91/ for test: gem_ccs
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: gem_lmem_swapping
results: parsing output: 96/ for test: vgem_basic
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: i915_pm_freq_api
results: parsing output: 99/ for test: kms_invalid_mode
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: i915_selftest
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: gem_render_copy
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: core_setmaster_vs_auth
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: syncobj_wait
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_store
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: testdisplay
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: gem_eio
results: parsing output: 131/ for test: gem_exec_params
results: parsing output: 132/ for test: syncobj_timeline
results: parsing output: 133/ for test: gen9_exec_parse
Done.