[56.632884] Initializing watchdogs
[56.632935]   /dev/watchdog0
[56.647640] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.652394] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.654780] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.658729] [001/133] (960s left) perf (invalid-open-flags)
[56.801531] Starting subtest: invalid-open-flags
[56.803805] Subtest invalid-open-flags: SUCCESS (0.000s)
[56.846051] [002/133] (960s left) kms_properties (connector-properties-legacy)
[56.948142] Starting subtest: connector-properties-legacy
[56.950549] Starting dynamic subtest: pipe-A-eDP-1
[64.774527] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.827s)
[64.783151] Starting dynamic subtest: pipe-None-DP-1
[64.787229] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[64.793634] Starting dynamic subtest: pipe-None-HDMI-A-1
[64.797704] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[64.804532] Starting dynamic subtest: pipe-None-DP-2
[64.808932] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[64.815783] Starting dynamic subtest: pipe-None-HDMI-A-2
[64.820175] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[64.827142] Starting dynamic subtest: pipe-None-DP-3
[64.831592] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[64.838536] Starting dynamic subtest: pipe-None-DP-4
[64.843140] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[64.845483] Subtest connector-properties-legacy: SUCCESS (7.836s)
[65.648521] [003/133] (951s left) kms_psr (psr2-cursor-render)
[65.749707] Starting subtest: psr2-cursor-render
[65.751915] Starting dynamic subtest: eDP-1
[67.425502] Dynamic subtest eDP-1: SUCCESS (1.677s)
[67.427853] Subtest psr2-cursor-render: SUCCESS (1.677s)
[68.220213] [004/133] (949s left) perf (non-zero-reason)
[68.322106] Starting subtest: non-zero-reason
[68.324461] Starting dynamic subtest: 0-rcs0
[73.738978] Dynamic subtest 0-rcs0: SUCCESS (5.415s)
[73.750382] Starting dynamic subtest: 1-vcs0
[77.658755] Dynamic subtest 1-vcs0: SUCCESS (3.919s)
[77.661715] Subtest non-zero-reason: SUCCESS (9.335s)
[77.707750] [005/133] (939s left) kms_plane_alpha_blend (alpha-7efc)
[77.807018] Starting subtest: alpha-7efc
[78.099709] Starting dynamic subtest: pipe-A-eDP-1
[78.688781] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[78.717782] Starting dynamic subtest: pipe-D-eDP-1
[80.018354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[80.020963] Subtest alpha-7efc: SUCCESS (2.213s)
[80.876588] [006/133] (936s left) kms_flip (bo-too-big-interruptible)
[80.988316] Starting subtest: bo-too-big-interruptible
[80.990644] Starting dynamic subtest: A-eDP1
[82.335054] Dynamic subtest A-eDP1: SUCCESS (1.346s)
[82.347332] Starting dynamic subtest: B-eDP1
[83.681418] Dynamic subtest B-eDP1: SUCCESS (1.346s)
[83.691180] Starting dynamic subtest: C-eDP1
[85.019273] Dynamic subtest C-eDP1: SUCCESS (1.337s)
[85.028306] Starting dynamic subtest: D-eDP1
[86.266535] Dynamic subtest D-eDP1: SUCCESS (1.245s)
[86.271692] Subtest bo-too-big-interruptible: SUCCESS (5.282s)
[87.491721] [007/133] (929s left) i915_drm_fdinfo (memory-info-shared)
[87.537582] Starting subtest: memory-info-shared
[87.539999] Starting dynamic subtest: smem0
[87.598020] Dynamic subtest smem0: SUCCESS (0.060s)
[87.600884] Subtest memory-info-shared: SUCCESS (0.060s)
[87.688209] [008/133] (929s left) sw_sync (alloc_merge_fence)
[87.721091] Starting subtest: alloc_merge_fence
[87.723519] Subtest alloc_merge_fence: SUCCESS (0.001s)
[87.784751] [009/133] (929s left) fbdev (read)
[87.822560] Starting subtest: read
[88.367866] Subtest read: SUCCESS (0.543s)
[88.426741] [010/133] (929s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[88.517382] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[88.521703] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[88.617958] [011/133] (928s left) gem_exec_reloc (basic-cpu-read-noreloc)
[88.677710] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[88.752155] [012/133] (928s left) gem_pxp (hw-rejects-pxp-buffer)
[88.870713] Starting subtest: hw-rejects-pxp-buffer
[88.875914] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[88.972508] [013/133] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[89.073686] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[96.223282] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.153s)
[96.354216] [014/133] (921s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[96.610136] Starting subtest: cursor-rapid-movement-512x512
[96.614881] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[96.752486] [015/133] (920s left) syncobj_wait (single-wait-submitted)
[96.799595] Starting subtest: single-wait-submitted
[96.904167] Subtest single-wait-submitted: SUCCESS (0.104s)
[96.984898] [016/133] (920s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[97.088077] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[97.092279] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[97.168855] [017/133] (920s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[97.262735] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[104.110274] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.851s)
[104.237064] [018/133] (913s left) gem_exec_schedule (pi-distinct-iova)
[104.436740] Starting subtest: pi-distinct-iova
[104.439226] Starting dynamic subtest: rcs0
[104.512009] Dynamic subtest rcs0: SUCCESS (0.078s)
[104.523459] Starting dynamic subtest: vcs0
[104.568604] Dynamic subtest vcs0: SUCCESS (0.056s)
[104.580594] Starting dynamic subtest: vcs1
[104.631483] Dynamic subtest vcs1: SUCCESS (0.062s)
[104.639696] Starting dynamic subtest: vecs0
[104.687733] Dynamic subtest vecs0: SUCCESS (0.056s)
[104.695715] Starting dynamic subtest: ccs0
[104.749958] Dynamic subtest ccs0: SUCCESS (0.061s)
[104.752603] Subtest pi-distinct-iova: SUCCESS (0.317s)
[106.406534] [019/133] (911s left) kms_chamelium_edid (dp-edid-read)
[106.797761] Subtest dp-edid-read: SKIP (0.000s)
[107.578780] [020/133] (910s left) gen9_exec_parse (bb-start-out)
[107.646775] Subtest bb-start-out: SKIP (0.000s)
[107.715216] [021/133] (910s left) kms_psr (fbc-psr2-basic)
[107.812195] Starting subtest: fbc-psr2-basic
[107.814069] Starting dynamic subtest: eDP-1
[107.818116] Dynamic subtest eDP-1: SKIP (0.000s)
[107.822103] Subtest fbc-psr2-basic: SKIP (0.001s)
[107.881080] [022/133] (910s left) kms_big_fb (linear-64bpp-rotate-270)
[107.983352] Starting subtest: linear-64bpp-rotate-270
[108.003934] Subtest linear-64bpp-rotate-270: SKIP (0.020s)
[108.105233] [023/133] (909s left) gem_mmap (bad-object)
[108.170575] Subtest bad-object: SKIP (0.000s)
[108.229637] [024/133] (909s left) syncobj_timeline (multi-wait-available-signaled)
[108.288731] Starting subtest: multi-wait-available-signaled
[108.291062] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[108.401255] [025/133] (909s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[108.499259] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[108.503506] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[108.592449] [026/133] (909s left) gem_tiled_pread_basic (basic)
[108.652915] Subtest basic: SKIP (0.000s)
[108.705426] [027/133] (909s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[108.763971] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[108.871999] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[108.957488] [028/133] (909s left) kms_cursor_edge_walk (64x64-right-edge)
[109.039129] Starting subtest: 64x64-right-edge
[109.041407] Starting dynamic subtest: pipe-A-eDP-1
[112.470631] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s)
[112.482126] Starting dynamic subtest: pipe-D-eDP-1
[115.585771] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[115.588160] Subtest 64x64-right-edge: SUCCESS (6.546s)
[116.399891] [029/133] (901s left) kms_flip (flip-vs-expired-vblank-interruptible)
[116.506701] Starting subtest: flip-vs-expired-vblank-interruptible
[116.509085] Starting dynamic subtest: A-eDP1
[125.213665] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[125.222332] Starting dynamic subtest: B-eDP1
[133.838405] Dynamic subtest B-eDP1: SUCCESS (8.623s)
[133.846205] Starting dynamic subtest: C-eDP1
[142.462228] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[142.470260] Starting dynamic subtest: D-eDP1
[151.091456] Dynamic subtest D-eDP1: SUCCESS (8.627s)
[151.093791] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.588s)
[152.262910] [030/133] (866s left) syncobj_timeline (single-wait-for-submit-signaled)
[152.318956] Starting subtest: single-wait-for-submit-signaled
[152.321401] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[152.406716] [031/133] (865s left) gem_ctx_persistence (heartbeat-stop)
[152.464064] Starting subtest: heartbeat-stop
[152.468819] Subtest heartbeat-stop: SKIP (0.000s)
[152.579399] [032/133] (865s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[152.660078] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[152.662380] Starting dynamic subtest: pipe-A-eDP-1
[152.685473] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.697278] Starting dynamic subtest: pipe-B-eDP-1
[152.719035] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.726639] Starting dynamic subtest: pipe-C-eDP-1
[152.748202] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.755419] Starting dynamic subtest: pipe-D-eDP-1
[152.777630] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.782044] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[154.942698] [033/133] (863s left) gem_shrink (reclaim)
[155.006829] Starting subtest: reclaim
[157.450938] Subtest reclaim: SUCCESS (2.444s)
[157.589043] [034/133] (860s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[157.681907] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[157.707774] Starting dynamic subtest: pipe-A-plane-0
[158.032752] Dynamic subtest pipe-A-plane-0: SUCCESS (0.322s)
[158.041637] Starting dynamic subtest: pipe-A-plane-3
[158.263607] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[159.333175] Starting dynamic subtest: pipe-B-plane-0
[159.637752] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[159.645791] Starting dynamic subtest: pipe-B-plane-3
[159.880958] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[160.192594] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.510s)
[161.023847] [035/133] (857s left) kms_color (ctm-signed)
[161.127505] Starting subtest: ctm-signed
[161.129836] Starting dynamic subtest: pipe-A-eDP-1
[163.210762] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.082s)
[163.219704] Starting dynamic subtest: pipe-B-eDP-1
[166.084488] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.875s)
[166.095162] Starting dynamic subtest: pipe-C-eDP-1
[168.798646] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.713s)
[168.806497] Starting dynamic subtest: pipe-D-eDP-1
[171.457626] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.658s)
[171.459976] Subtest ctm-signed: SUCCESS (10.330s)
[172.293691] [036/133] (846s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[172.388313] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[172.390657] Starting dynamic subtest: pipe-A-default-mode
[173.533465] Dynamic subtest pipe-A-default-mode: SKIP (1.143s)
[173.537248] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.145s)
[173.671051] [037/133] (844s left) kms_content_protection (legacy-hdcp14)
[173.824496] Starting subtest: legacy-hdcp14
[173.829139] Subtest legacy-hdcp14: SKIP (0.000s)
[173.938883] [038/133] (844s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[174.031050] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[174.033301] Starting dynamic subtest: pipe-A
[175.134688] Dynamic subtest pipe-A: SUCCESS (1.106s)
[175.143202] Starting dynamic subtest: pipe-B
[177.339500] Dynamic subtest pipe-B: SUCCESS (2.204s)
[177.347053] Starting dynamic subtest: pipe-C
[178.513357] Dynamic subtest pipe-C: SUCCESS (1.172s)
[178.521704] Starting dynamic subtest: pipe-D
[179.737195] Dynamic subtest pipe-D: SUCCESS (1.222s)
[179.739663] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.709s)
[180.938265] [039/133] (837s left) kms_pm_rpm (system-suspend-modeset)
[182.475655] Starting subtest: system-suspend-modeset
[202.403608] Subtest system-suspend-modeset: SUCCESS (4.783s)
[202.814965] [040/133] (815s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[202.939214] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[202.943561] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[203.005123] [041/133] (815s left) gem_pread (uncached)
[203.062929] Subtest uncached: SKIP (0.000s)
[203.122347] [042/133] (815s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[203.245291] Starting subtest: 2x-cursor-vs-flip-legacy
[203.249751] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[203.388842] [043/133] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[203.483948] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[203.487937] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[203.570445] [044/133] (815s left) kms_lease (possible-crtcs-filtering)
[203.654473] Starting subtest: possible-crtcs-filtering
[203.659225] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[203.757240] [045/133] (815s left) kms_big_fb (y-tiled-addfb-size-overflow)
[203.848001] Starting subtest: y-tiled-addfb-size-overflow
[203.851435] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[203.964310] [046/133] (814s left) api_intel_allocator (default-alignment)
[204.031078] Starting subtest: default-alignment
[204.033078] Subtest default-alignment: SUCCESS (0.003s)
[204.154803] [047/133] (814s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[204.244288] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[204.247696] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[204.340402] [048/133] (814s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[204.730262] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[205.507307] [049/133] (813s left) kms_dsc (dsc-with-output-formats)
[205.603174] Starting subtest: dsc-with-output-formats
[205.623626] Subtest dsc-with-output-formats: SKIP (0.001s)
[205.675358] [050/133] (813s left) gem_exec_schedule (smoketest)
[205.856861] Starting subtest: smoketest
[205.859482] Starting dynamic subtest: rcs0
[211.412278] Dynamic subtest rcs0: SUCCESS (5.509s)
[211.424255] Starting dynamic subtest: bcs0
[216.925777] Dynamic subtest bcs0: SUCCESS (5.503s)
[216.936625] Starting dynamic subtest: vcs0
[222.420451] Dynamic subtest vcs0: SUCCESS (5.494s)
[222.430693] Starting dynamic subtest: vcs1
[227.922949] Dynamic subtest vcs1: SUCCESS (5.501s)
[227.940065] Starting dynamic subtest: vecs0
[233.434653] Dynamic subtest vecs0: SUCCESS (5.512s)
[233.444976] Starting dynamic subtest: ccs0
[238.931333] Dynamic subtest ccs0: SUCCESS (5.492s)
[238.933428] Subtest smoketest: SUCCESS (33.018s)
[239.071265] [051/133] (780s left) gem_caching (reads)
[239.143369] Subtest reads: SKIP (0.000s)
[239.213123] [052/133] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[239.311761] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[239.315691] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[239.396859] [053/133] (779s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[239.490403] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[239.492573] Starting dynamic subtest: pipe-A-eDP-1
[239.514595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.526592] Starting dynamic subtest: pipe-B-eDP-1
[239.547467] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.555526] Starting dynamic subtest: pipe-C-eDP-1
[239.575924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.583603] Starting dynamic subtest: pipe-D-eDP-1
[239.604171] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[239.608242] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[241.794442] [054/133] (777s left) perf_pmu (idle-no-semaphores)
[241.843052] Starting subtest: idle-no-semaphores
[241.845356] Starting dynamic subtest: rcs0
[242.388530] Dynamic subtest rcs0: SUCCESS (0.546s)
[242.401028] Starting dynamic subtest: bcs0
[242.905719] Dynamic subtest bcs0: SUCCESS (0.514s)
[242.916923] Starting dynamic subtest: vcs0
[243.421549] Dynamic subtest vcs0: SUCCESS (0.513s)
[243.432918] Starting dynamic subtest: vcs1
[243.945192] Dynamic subtest vcs1: SUCCESS (0.520s)
[243.957699] Starting dynamic subtest: vecs0
[244.463063] Dynamic subtest vecs0: SUCCESS (0.515s)
[244.475464] Starting dynamic subtest: ccs0
[244.980694] Dynamic subtest ccs0: SUCCESS (0.514s)
[244.983451] Subtest idle-no-semaphores: SUCCESS (3.140s)
[245.093727] [055/133] (774s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[245.193332] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[251.892744] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.702s)
[252.019301] [056/133] (767s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[252.107831] Starting subtest: plane-primary-toggle-with-vblank-wait
[252.110509] Starting dynamic subtest: pipe-A-eDP-1
[252.280161] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[252.588444] Starting dynamic subtest: pipe-B-eDP-1
[253.516510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.937s)
[253.818019] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.710s)
[254.680151] [057/133] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[254.779752] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[254.783829] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[254.870889] [058/133] (764s left) syncobj_timeline (invalid-transfer-non-existent-point)
[254.926674] Starting subtest: invalid-transfer-non-existent-point
[254.929038] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[255.032819] [059/133] (764s left) i915_pm_rpm (system-suspend)
[256.551417] Starting subtest: system-suspend
[274.618439] Subtest system-suspend: SUCCESS (2.850s)
[275.015955] [060/133] (744s left) kms_sequence (queue-busy)
[275.106731] Starting subtest: queue-busy
[275.109070] Starting dynamic subtest: pipe-A-eDP-1
[277.053325] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[277.065457] Starting dynamic subtest: pipe-B-eDP-1
[279.703680] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.649s)
[279.713417] Starting dynamic subtest: pipe-C-eDP-1
[282.308882] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[282.319117] Starting dynamic subtest: pipe-D-eDP-1
[284.935489] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.624s)
[284.937432] Subtest queue-busy: SUCCESS (9.821s)
[285.732834] [061/133] (733s left) kms_addfb_basic (bad-pitch-65536)
[285.791498] Starting subtest: bad-pitch-65536
[285.793679] Subtest bad-pitch-65536: SUCCESS (0.000s)
[285.921903] [062/133] (733s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[286.010614] Starting subtest: primary-yf-tiled-reflect-x-270
[286.014899] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[286.082322] [063/133] (733s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[286.178081] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[287.300709] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.123s)
[287.415694] [064/133] (732s left) perf (mi-rpc)
[287.510426] Starting subtest: mi-rpc
[287.513841] Subtest mi-rpc: SKIP (0.000s)
[287.555177] [065/133] (732s left) gem_exec_balancer (fairslice)
[287.613589] Starting subtest: fairslice
[290.588839] Subtest fairslice: SUCCESS (2.972s)
[291.704782] [066/133] (728s left) gem_exec_async (forked-writes)
[291.771822] Starting subtest: forked-writes
[291.773991] Starting dynamic subtest: rcs0
[291.802423] Dynamic subtest rcs0: SUCCESS (0.033s)
[291.816431] Starting dynamic subtest: bcs0
[291.828559] Dynamic subtest bcs0: SUCCESS (0.025s)
[291.838199] Starting dynamic subtest: vcs0
[291.854756] Dynamic subtest vcs0: SUCCESS (0.025s)
[291.864994] Starting dynamic subtest: vcs1
[291.881627] Dynamic subtest vcs1: SUCCESS (0.026s)
[291.891343] Starting dynamic subtest: vecs0
[291.906624] Dynamic subtest vecs0: SUCCESS (0.024s)
[291.916527] Starting dynamic subtest: ccs0
[291.931130] Dynamic subtest ccs0: SUCCESS (0.024s)
[291.933432] Subtest forked-writes: SUCCESS (0.163s)
[292.180707] [067/133] (727s left) gem_softpin (allocator-nopin)
[292.242260] Starting subtest: allocator-nopin
[292.347578] Subtest allocator-nopin: SUCCESS (0.104s)
[292.479288] [068/133] (727s left) gem_ctx_param (basic-default)
[292.530148] Starting subtest: basic-default
[292.532318] Subtest basic-default: SUCCESS (0.000s)
[292.616840] [069/133] (727s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[292.755936] Starting subtest: cursorA-vs-flipB-atomic-transitions
[292.760302] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[292.899103] [070/133] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[292.990878] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[292.995056] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[293.084939] [071/133] (726s left) gem_mmap_gtt (cpuset-basic-small-copy)
[293.138972] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[293.197624] [072/133] (726s left) gem_eio (in-flight-10ms)
[293.430086] Starting subtest: in-flight-10ms
[301.675554] Subtest in-flight-10ms: SUCCESS (8.243s)
[301.812401] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[301.815897] [073/133] (718s left) gem_cs_tlb (engines)
[301.882119] Starting subtest: engines
[301.884427] Starting dynamic subtest: rcs0
[304.038676] Dynamic subtest rcs0: SUCCESS (2.152s)
[304.049030] Starting dynamic subtest: bcs0
[306.192020] Dynamic subtest bcs0: SUCCESS (2.152s)
[306.203583] Starting dynamic subtest: vcs0
[308.345197] Dynamic subtest vcs0: SUCCESS (2.152s)
[308.357296] Starting dynamic subtest: vcs1
[310.498744] Dynamic subtest vcs1: SUCCESS (2.151s)
[310.509066] Starting dynamic subtest: vecs0
[312.652261] Dynamic subtest vecs0: SUCCESS (2.151s)
[312.664856] Starting dynamic subtest: ccs0
[314.807759] Dynamic subtest ccs0: SUCCESS (2.154s)
[314.810144] Subtest engines: SUCCESS (12.920s)
[314.924019] [074/133] (705s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[315.026252] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[316.071691] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.045s)
[316.208203] [075/133] (703s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[316.335562] Starting subtest: cursorB-vs-flipA-toggle
[316.339217] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[316.482386] [076/133] (703s left) gem_exec_reloc (basic-active)
[316.545480] Subtest basic-active: SKIP (0.000s)
[316.615171] [077/133] (703s left) gem_lmem_swapping (heavy-multi)
[316.658212] Subtest heavy-multi: SKIP (0.000s)
[316.704139] [078/133] (703s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[316.802347] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[316.804043] Starting dynamic subtest: pipe-A-eDP-1
[317.680115] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s)
[317.689838] Starting dynamic subtest: pipe-B-eDP-1
[319.298999] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.614s)
[319.309104] Starting dynamic subtest: pipe-C-eDP-1
[320.865964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.564s)
[320.876965] Starting dynamic subtest: pipe-D-eDP-1
[322.393944] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s)
[322.396171] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.584s)
[323.546057] [079/133] (696s left) i915_selftest (live)
[328.170081] Starting subtest: live
[328.172762] Starting dynamic subtest: sanitycheck
[332.502083] Dynamic subtest sanitycheck: SUCCESS (4.331s)
[332.511897] Starting dynamic subtest: uncore
[336.850750] Dynamic subtest uncore: SUCCESS (4.345s)
[336.861067] Starting dynamic subtest: workarounds
[354.512207] Dynamic subtest workarounds: FAIL (17.502s)
[354.519848] Starting dynamic subtest: gt_engines
[357.411417] Dynamic subtest gt_engines: SUCCESS (3.050s)
[357.425075] Starting dynamic subtest: gt_timelines
[375.180877] Dynamic subtest gt_timelines: SUCCESS (17.766s)
[375.190534] Starting dynamic subtest: gt_contexts
[379.548398] Dynamic subtest gt_contexts: SUCCESS (4.368s)
[379.557992] Starting dynamic subtest: gt_lrc
[385.847644] Dynamic subtest gt_lrc: SUCCESS (6.299s)
[385.857260] Starting dynamic subtest: gt_mocs
[388.882191] Dynamic subtest gt_mocs: SUCCESS (3.033s)
[388.893036] Starting dynamic subtest: gt_pm
[395.713795] Dynamic subtest gt_pm: SUCCESS (6.830s)
[395.723110] Starting dynamic subtest: gt_heartbeat
[400.485967] Dynamic subtest gt_heartbeat: SUCCESS (4.770s)
[400.496515] Starting dynamic subtest: gt_tlb
[409.766703] Dynamic subtest gt_tlb: SUCCESS (9.278s)
[409.777432] Starting dynamic subtest: requests
[421.280800] Dynamic subtest requests: SUCCESS (11.514s)
[421.290761] Starting dynamic subtest: migrate
[427.062716] Dynamic subtest migrate: SUCCESS (5.779s)
[427.073013] Starting dynamic subtest: active
[429.745982] Dynamic subtest active: SUCCESS (2.682s)
[429.755781] Starting dynamic subtest: objects
[434.415073] Dynamic subtest objects: SUCCESS (4.667s)
[434.425670] Starting dynamic subtest: mman
[437.803045] Dynamic subtest mman: SUCCESS (3.387s)
[437.812986] Starting dynamic subtest: dmabuf
[440.552325] Dynamic subtest dmabuf: SUCCESS (2.747s)
[440.562149] Starting dynamic subtest: vma
[444.972376] Dynamic subtest vma: SUCCESS (4.419s)
[444.981676] Starting dynamic subtest: coherency
[450.060862] Dynamic subtest coherency: SUCCESS (5.086s)
[450.070640] Starting dynamic subtest: gtt
[460.143741] Dynamic subtest gtt: SUCCESS (10.080s)
[460.154191] Starting dynamic subtest: gem
[468.330722] Dynamic subtest gem: SUCCESS (8.184s)
[468.341025] Starting dynamic subtest: evict
[473.763692] Dynamic subtest evict: SUCCESS (5.430s)
[473.774422] Starting dynamic subtest: hugepages
[482.543328] Dynamic subtest hugepages: SUCCESS (8.778s)
[482.553520] Starting dynamic subtest: gem_contexts
[509.567958] Dynamic subtest gem_contexts: SUCCESS (27.020s)
[509.578277] Starting dynamic subtest: client
[512.341022] Dynamic subtest client: SUCCESS (2.772s)
[512.350949] Starting dynamic subtest: gem_migrate
[516.687675] Dynamic subtest gem_migrate: SUCCESS (4.345s)
[516.697482] Starting dynamic subtest: reset
[521.099861] Dynamic subtest reset: SUCCESS (4.412s)
[521.109669] Starting dynamic subtest: memory_region
[525.395117] Dynamic subtest memory_region: SUCCESS (4.293s)
[525.409419] Starting dynamic subtest: hangcheck
[538.876398] Dynamic subtest hangcheck: SUCCESS (13.479s)
[538.886698] Starting dynamic subtest: execlists
[543.215399] Dynamic subtest execlists: SUCCESS (4.337s)
[543.225909] Starting dynamic subtest: ring_submission
[547.526027] Dynamic subtest ring_submission: SUCCESS (4.308s)
[547.536431] Starting dynamic subtest: perf
[551.894556] Dynamic subtest perf: SUCCESS (4.366s)
[551.907414] Starting dynamic subtest: slpc
[563.923298] Dynamic subtest slpc: SUCCESS (12.027s)
[563.932796] Starting dynamic subtest: guc
[567.795759] Dynamic subtest guc: SUCCESS (3.870s)
[567.806032] Starting dynamic subtest: guc_multi_lrc
[572.100199] Dynamic subtest guc_multi_lrc: SUCCESS (4.303s)
[572.110849] Starting dynamic subtest: guc_hang
[577.009141] Dynamic subtest guc_hang: SUCCESS (4.908s)
[577.019758] Starting dynamic subtest: late_gt_pm
[581.384385] Dynamic subtest late_gt_pm: SUCCESS (4.374s)
[581.387203] Subtest live: FAIL (253.204s)
[581.416169] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[581.416875] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[581.419947] [080/133] (438s left) gem_exec_fence (submit-chain)
[583.109139] Starting subtest: submit-chain
[583.131310] Subtest submit-chain: SUCCESS (0.022s)
[584.713276] [FACT gem_exec_fence (submit-chain)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[584.714784] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.i915: true
[584.719109] [081/133] (435s left) kms_prop_blob (blob-prop-validate)
[584.786503] Starting subtest: blob-prop-validate
[584.788917] Subtest blob-prop-validate: SUCCESS (0.000s)
[584.880597] [082/133] (435s left) core_setmaster_vs_auth
[585.062301] [083/133] (435s left) kms_cursor_crc (cursor-onscreen-512x170)
[585.387749] Starting subtest: cursor-onscreen-512x170
[585.392519] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[585.552843] [084/133] (434s left) sysfs_timeslice_duration (idempotent)
[585.611225] Starting subtest: idempotent
[585.613708] Starting dynamic subtest: vecs0
[585.616064] Dynamic subtest vecs0: SUCCESS (0.000s)
[585.628167] Starting dynamic subtest: ccs0
[585.630405] Dynamic subtest ccs0: SUCCESS (0.000s)
[585.639594] Starting dynamic subtest: vcs0
[585.641822] Dynamic subtest vcs0: SUCCESS (0.001s)
[585.650734] Starting dynamic subtest: bcs0
[585.652989] Dynamic subtest bcs0: SUCCESS (0.001s)
[585.661673] Starting dynamic subtest: rcs0
[585.663949] Dynamic subtest rcs0: SUCCESS (0.000s)
[585.673131] Starting dynamic subtest: vcs1
[585.675053] Dynamic subtest vcs1: SUCCESS (0.000s)
[585.676951] Subtest idempotent: SUCCESS (0.008s)
[585.735844] [085/133] (434s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[585.832760] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[585.834800] Starting dynamic subtest: pipe-A
[585.858902] Dynamic subtest pipe-A: SKIP (0.021s)
[585.868071] Starting dynamic subtest: pipe-B
[585.894450] Dynamic subtest pipe-B: SKIP (0.035s)
[585.903267] Starting dynamic subtest: pipe-C
[585.933400] Dynamic subtest pipe-C: SKIP (0.037s)
[585.942249] Starting dynamic subtest: pipe-D
[585.967802] Dynamic subtest pipe-D: SKIP (0.035s)
[585.970988] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.132s)
[586.073161] [086/133] (434s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[586.174849] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[586.303732] [087/133] (434s left) gem_exec_store (pages)
[586.378405] Starting subtest: pages
[586.380421] Starting dynamic subtest: rcs0
[586.483333] Dynamic subtest rcs0: SUCCESS (0.107s)
[586.495238] Starting dynamic subtest: bcs0
[586.562851] Dynamic subtest bcs0: SUCCESS (0.078s)
[586.572947] Starting dynamic subtest: vcs0
[586.630780] Dynamic subtest vcs0: SUCCESS (0.067s)
[586.640820] Starting dynamic subtest: vcs1
[586.702011] Dynamic subtest vcs1: SUCCESS (0.070s)
[586.713206] Starting dynamic subtest: vecs0
[586.782038] Dynamic subtest vecs0: SUCCESS (0.079s)
[586.793208] Starting dynamic subtest: ccs0
[586.849346] Dynamic subtest ccs0: SUCCESS (0.066s)
[586.851502] Subtest pages: SUCCESS (0.474s)
[587.030933] [088/133] (433s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[587.123519] Starting subtest: async-flip-with-page-flip-events-tiled
[587.498722] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[590.281431] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.781s)
[590.295406] Starting dynamic subtest: pipe-A-eDP-1-4
[592.477696] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.195s)
[592.490070] Starting dynamic subtest: pipe-A-eDP-1-4
[594.487870] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[594.497902] Starting dynamic subtest: pipe-A-eDP-1-x
[596.678445] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[597.046609] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[599.810664] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.771s)
[599.821209] Starting dynamic subtest: pipe-B-eDP-1-4
[601.996149] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[602.005958] Starting dynamic subtest: pipe-B-eDP-1-4
[604.005756] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[604.016121] Starting dynamic subtest: pipe-B-eDP-1-x
[606.196712] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[606.594947] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[609.338464] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.751s)
[609.349032] Starting dynamic subtest: pipe-C-eDP-1-4
[611.513629] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[611.525896] Starting dynamic subtest: pipe-C-eDP-1-4
[613.524181] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[613.534785] Starting dynamic subtest: pipe-C-eDP-1-x
[615.702592] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[616.063211] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[618.863424] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.805s)
[618.877240] Starting dynamic subtest: pipe-D-eDP-1-4
[621.037631] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[621.047834] Starting dynamic subtest: pipe-D-eDP-1-4
[623.047522] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s)
[623.058037] Starting dynamic subtest: pipe-D-eDP-1-x
[625.226560] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s)
[625.229015] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.101s)
[626.448878] [089/133] (394s left) core_setmaster (master-drop-set-root)
[626.507748] Starting subtest: master-drop-set-root
[626.532178] Subtest master-drop-set-root: SUCCESS (0.025s)
[626.581914] [090/133] (394s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[626.672964] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[626.677170] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[626.774687] [091/133] (394s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[626.863661] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[634.195498] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.335s)
[634.320765] [092/133] (386s left) syncobj_wait (reset-signaled)
[634.382985] Starting subtest: reset-signaled
[634.385296] Subtest reset-signaled: SUCCESS (0.000s)
[634.487954] [093/133] (386s left) kms_async_flips (invalid-async-flip)
[634.594513] Starting subtest: invalid-async-flip
[634.970461] Starting dynamic subtest: pipe-A-eDP-1
[635.779745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[636.145485] Starting dynamic subtest: pipe-B-eDP-1
[636.923601] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s)
[637.288701] Starting dynamic subtest: pipe-C-eDP-1
[638.056814] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[638.412435] Starting dynamic subtest: pipe-D-eDP-1
[639.185057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.780s)
[639.187421] Subtest invalid-async-flip: SUCCESS (4.593s)
[640.339751] [094/133] (380s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[640.449629] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[640.454047] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[640.526935] [095/133] (380s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[640.625288] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[648.036613] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.414s)
[648.195241] [096/133] (372s left) gem_pwrite (basic-exhaustion)
[648.265810] Subtest basic-exhaustion: SKIP (0.000s)
[648.337542] [097/133] (372s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[648.443329] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[649.279126] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[649.491680] [098/133] (371s left) gem_userptr_blits (usage-restrictions)
[649.560882] Starting subtest: usage-restrictions
[649.562982] Subtest usage-restrictions: SUCCESS (0.000s)
[649.702446] [099/133] (371s left) gem_ctx_param (invalid-get-engines)
[649.754062] Starting subtest: invalid-get-engines
[649.756174] Subtest invalid-get-engines: SUCCESS (0.001s)
[649.867069] [100/133] (371s left) kms_pm_backlight (brightness-with-dpms)
[649.969365] Starting subtest: brightness-with-dpms
[650.021223] Starting dynamic subtest: eDP-1
[652.467663] Dynamic subtest eDP-1: SUCCESS (2.444s)
[652.469955] Subtest brightness-with-dpms: SUCCESS (2.499s)
[653.331739] [101/133] (367s left) gem_sync (basic-many-each)
[653.414526] Starting subtest: basic-many-each
[655.694317] Subtest basic-many-each: SUCCESS (2.289s)
[655.878482] [102/133] (365s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[655.981119] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[655.983688] Starting dynamic subtest: pipe-A-eDP-1
[656.004249] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[656.016501] Starting dynamic subtest: pipe-B-eDP-1
[656.035642] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[656.045597] Starting dynamic subtest: pipe-C-eDP-1
[656.065411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[656.075102] Starting dynamic subtest: pipe-D-eDP-1
[656.094898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[656.097144] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.009s)
[658.228218] [103/133] (363s left) perf (create-destroy-userspace-config)
[658.346737] Starting subtest: create-destroy-userspace-config
[658.368412] Subtest create-destroy-userspace-config: SUCCESS (0.022s)
[658.418916] [104/133] (362s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[658.514145] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[662.743743] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.232s)
[663.936402] [105/133] (357s left) gem_exec_params (sol-reset-not-gen7)
[663.999086] Starting subtest: sol-reset-not-gen7
[664.001624] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[664.114187] [106/133] (357s left) kms_flip (2x-blocking-wf_vblank)
[664.209529] Starting subtest: 2x-blocking-wf_vblank
[664.218683] Subtest 2x-blocking-wf_vblank: SKIP (0.011s)
[664.304290] [107/133] (357s left) kms_chamelium_audio (dp-audio)
[664.696198] Subtest dp-audio: SKIP (0.000s)
[665.531259] [108/133] (356s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[665.591705] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[665.596197] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[665.775772] [109/133] (355s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[665.866133] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[665.868427] Starting dynamic subtest: pipe-A-eDP-1
[665.891033] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[665.904031] Starting dynamic subtest: pipe-B-eDP-1
[665.925446] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[665.934932] Starting dynamic subtest: pipe-C-eDP-1
[665.956909] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[665.966175] Starting dynamic subtest: pipe-D-eDP-1
[665.988073] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[665.992520] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[668.138194] [110/133] (353s left) kms_vblank (wait-busy-hang)
[668.228515] Starting subtest: wait-busy-hang
[668.230431] Starting dynamic subtest: pipe-A-eDP-1
[694.448479] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.217s)
[694.465055] Starting dynamic subtest: pipe-D-eDP-1
[709.477589] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.025s)
[709.479966] Subtest wait-busy-hang: SUCCESS (41.247s)
[710.298613] [111/133] (311s left) kms_hdr (static-toggle)
[710.388060] Starting subtest: static-toggle
[710.394637] Subtest static-toggle: SKIP (0.000s)
[710.463755] [112/133] (311s left) gem_exec_fence (concurrent)
[710.640692] Starting subtest: concurrent
[710.645394] Subtest concurrent: SKIP (0.000s)
[712.748216] [113/133] (309s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[712.847153] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[712.851510] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[712.947479] [114/133] (308s left) kms_force_connector_basic (force-load-detect)
[713.017519] Starting subtest: force-load-detect
[713.021836] Subtest force-load-detect: SKIP (0.000s)
[713.145785] [115/133] (308s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[713.268912] Starting subtest: cursor-vs-flip-atomic-transitions
[743.679286] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.404s)
[744.538253] [116/133] (277s left) kms_psr (pr-suspend)
[744.631396] Starting subtest: pr-suspend
[744.635724] Subtest pr-suspend: SKIP (0.000s)
[744.704557] [117/133] (277s left) kms_getfb (getfb-handle-closed)
[744.808653] Starting subtest: getfb-handle-closed
[744.810933] Subtest getfb-handle-closed: SUCCESS (0.000s)
[744.913171] [118/133] (277s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[745.007011] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[745.011099] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[745.106759] [119/133] (276s left) gem_exec_reloc (basic-cpu-active)
[745.174972] Subtest basic-cpu-active: SKIP (0.000s)
[745.238937] [120/133] (276s left) template (a)
[745.296858] Starting subtest: A
[745.299285] Subtest A: SUCCESS (0.000s)
[745.406837] [121/133] (276s left) vgem_basic (setversion)
[745.459602] Starting subtest: setversion
[745.464037] Subtest setversion: SUCCESS (0.000s)
[745.513729] [122/133] (276s left) kms_psr (psr-sprite-blt)
[745.618943] Starting subtest: psr-sprite-blt
[745.620876] Starting dynamic subtest: eDP-1
[747.358822] Dynamic subtest eDP-1: SUCCESS (1.739s)
[747.361011] Subtest psr-sprite-blt: SUCCESS (1.740s)
[748.187016] [123/133] (273s left) i915_pm_freq_api (freq-suspend)
[748.250521] Starting subtest: freq-suspend
[748.252869] Starting dynamic subtest: gt0
[764.810249] Dynamic subtest gt0: SUCCESS (1.225s)
[764.823713] Starting dynamic subtest: gt1
[780.809040] Dynamic subtest gt1: SUCCESS (1.224s)
[780.811462] Subtest freq-suspend: SUCCESS (2.452s)
[781.893083] [124/133] (241s left) syncobj_wait (invalid-reset-bad-pad)
[781.962610] Starting subtest: invalid-reset-bad-pad
[781.965317] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[782.062677] [125/133] (241s left) kms_psr (fbc-psr2-sprite-plane-move)
[782.157185] Starting subtest: fbc-psr2-sprite-plane-move
[782.159581] Starting dynamic subtest: eDP-1
[782.164155] Dynamic subtest eDP-1: SKIP (0.000s)
[782.169095] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[782.258186] [126/133] (241s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[782.314473] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[782.416320] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[782.502450] [127/133] (240s left) perf_pmu (semaphore-busy)
[782.550303] Starting subtest: semaphore-busy
[782.552830] Starting dynamic subtest: rcs0
[784.195832] Dynamic subtest rcs0: SUCCESS (1.648s)
[784.209147] Starting dynamic subtest: bcs0
[784.826038] Dynamic subtest bcs0: FAIL (0.554s)
[784.837129] Starting dynamic subtest: vcs0
[785.383833] Dynamic subtest vcs0: FAIL (0.553s)
[785.394582] Starting dynamic subtest: vcs1
[787.342101] Dynamic subtest vcs1: FAIL (1.967s)
[787.353565] Starting dynamic subtest: vecs0
[789.394982] Dynamic subtest vecs0: FAIL (2.051s)
[789.405588] Starting dynamic subtest: ccs0
[791.381179] Dynamic subtest ccs0: FAIL (1.985s)
[791.384049] Subtest semaphore-busy: FAIL (8.766s)
[791.430716] [128/133] (232s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[791.535958] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[791.538488] Starting dynamic subtest: pipe-A-eDP-1
[797.441060] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.913s)
[797.451944] Starting dynamic subtest: pipe-B-eDP-1
[804.076370] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[804.079323] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.554s)
[804.946696] [129/133] (218s left) gem_exec_create (forked)
[805.015131] Starting subtest: forked
[805.017571] Starting dynamic subtest: smem
[826.752659] Dynamic subtest smem: SUCCESS (21.742s)
[826.755106] Subtest forked: SUCCESS (21.745s)
[826.942142] [130/133] (196s left) api_intel_bb (destroy-bb)
[827.000007] Starting subtest: destroy-bb
[827.015191] Subtest destroy-bb: SUCCESS (0.015s)
[827.147357] [131/133] (196s left) kms_dp_link_training (non-uhbr-mst)
[827.241492] Starting subtest: non-uhbr-mst
[827.250311] Subtest non-uhbr-mst: SKIP (0.000s)
[827.315444] [132/133] (196s left) gem_mmap_gtt (hang-busy)
[827.363764] Subtest hang-busy: SKIP (0.000s)
[827.428375] [133/133] (196s left) kms_flip (flip-vs-suspend)
[827.516625] Starting subtest: flip-vs-suspend
[827.519156] Starting dynamic subtest: A-eDP1
[972.834772] Dynamic subtest A-eDP1: SUCCESS (11.334s)
[972.837421] Subtest flip-vs-suspend: SUCCESS (11.336s)
[972.976176] Closing watchdogs
results: parsing output: 0/ for test: perf
results: parsing output: 1/ for test: kms_properties
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: kms_plane_alpha_blend
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: i915_drm_fdinfo
results: parsing output: 7/ for test: sw_sync
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: syncobj_wait
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: kms_chamelium_edid
results: parsing output: 19/ for test: gen9_exec_parse
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_mmap
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_tiled_pread_basic
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_shrink
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_content_protection
results: parsing output: 37/ for test: kms_plane_scaling
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_psr2_sf
results: parsing output: 40/ for test: gem_pread
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_lease
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: api_intel_allocator
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_hpd
results: parsing output: 48/ for test: kms_dsc
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: gem_caching
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: perf_pmu
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_atomic_transition
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: i915_pm_rpm
results: parsing output: 59/ for test: kms_sequence
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: perf
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: gem_exec_async
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: gem_eio
results: parsing output: 72/ for test: gem_cs_tlb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: gem_lmem_swapping
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: i915_selftest
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_prop_blob
results: parsing output: 81/ for test: core_setmaster_vs_auth
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: sysfs_timeslice_duration
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_exec_store
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: core_setmaster
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_async_flips
results: parsing output: 93/ for test: kms_plane
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_userptr_blits
results: parsing output: 98/ for test: gem_ctx_param
results: parsing output: 99/ for test: kms_pm_backlight
results: parsing output: 100/ for test: gem_sync
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_chamelium_audio
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: kms_hdr
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_force_connector_basic
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: template
results: parsing output: 120/ for test: vgem_basic
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: i915_pm_freq_api
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: perf_pmu
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: gem_exec_create
results: parsing output: 129/ for test: api_intel_bb
results: parsing output: 130/ for test: kms_dp_link_training
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_flip
Done.