[46.384290] Initializing watchdogs
[46.384351]   /dev/watchdog0
[46.399711] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[46.405768] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.408242] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.410077] [001/133] (960s left) gem_ringfill (legacy-basic)
[46.658692] Starting subtest: legacy-basic
[46.659725] Starting dynamic subtest: default
[46.686659] Dynamic subtest default: SUCCESS (0.034s)
[46.700874] Starting dynamic subtest: render
[46.712315] Dynamic subtest render: SUCCESS (0.025s)
[46.723280] Starting dynamic subtest: bsd
[46.736198] Dynamic subtest bsd: SUCCESS (0.023s)
[46.747042] Starting dynamic subtest: bsd1
[46.759166] Dynamic subtest bsd1: SUCCESS (0.022s)
[46.769040] Starting dynamic subtest: bsd2
[46.781411] Dynamic subtest bsd2: SUCCESS (0.021s)
[46.792749] Starting dynamic subtest: blt
[46.803376] Dynamic subtest blt: SUCCESS (0.021s)
[46.812722] Starting dynamic subtest: vebox
[46.823432] Dynamic subtest vebox: SUCCESS (0.019s)
[46.824346] Subtest legacy-basic: SUCCESS (0.172s)
[46.890656] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[46.892505] [002/133] (960s left) kms_flip (flip-vs-suspend)
[46.980274] Starting subtest: flip-vs-suspend
[46.982098] Starting dynamic subtest: A-HDMI-A1
[95.404191] Dynamic subtest A-HDMI-A1: SUCCESS (3.863s)
[95.412225] Starting dynamic subtest: B-HDMI-A1
[143.408855] Dynamic subtest B-HDMI-A1: SUCCESS (3.646s)
[143.416095] Starting dynamic subtest: C-HDMI-A1
[191.385356] Dynamic subtest C-HDMI-A1: SUCCESS (3.698s)
[191.391796] Starting dynamic subtest: D-HDMI-A1
[239.388278] Dynamic subtest D-HDMI-A1: SUCCESS (3.556s)
[239.390332] Subtest flip-vs-suspend: SUCCESS (14.770s)
[248.581537] [003/133] (767s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[248.683745] Starting subtest: cursorB-vs-flipA-legacy
[248.686365] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[248.739640] [004/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[248.828450] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[248.829773] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[248.918741] [005/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[249.007690] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[249.009045] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[249.090083] [006/133] (767s left) gem_exec_balancer (individual)
[249.131146] Starting subtest: individual
[250.714006] Subtest individual: SUCCESS (1.570s)
[250.888637] [007/133] (765s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[250.976909] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[250.978329] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[251.145422] [008/133] (765s left) perf (short-reads)
[251.227552] Starting subtest: short-reads
[251.244700] Subtest short-reads: SUCCESS (0.017s)
[251.286946] [009/133] (764s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[251.326614] Starting subtest: yf-tiled-ccs-to-x-tiled
[251.327346] Starting dynamic subtest: smem
[251.427406] Dynamic subtest smem: SUCCESS (0.100s)
[251.428118] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.101s)
[251.608929] [010/133] (764s left) kms_psr (fbc-pr-cursor-render)
[251.693242] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[251.736683] [011/133] (764s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[251.824536] Starting subtest: psr-1p-pri-indfb-multidraw
[251.825899] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s)
[251.916051] [012/133] (764s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[251.950544] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[252.059961] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.107s)
[252.126905] [013/133] (764s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[252.159812] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[252.202308] [014/133] (764s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[252.287605] Starting subtest: compare-crc-sanitycheck-nv12
[252.288282] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.632323] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.343s)
[252.640839] Starting dynamic subtest: pipe-B-HDMI-A-1
[252.959274] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.324s)
[252.967368] Starting dynamic subtest: pipe-C-HDMI-A-1
[253.271211] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.310s)
[253.281544] Starting dynamic subtest: pipe-D-HDMI-A-1
[253.584323] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.311s)
[253.585042] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.295s)
[253.727430] [015/133] (762s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[253.823648] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[254.941060] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (1.116s)
[255.058251] [016/133] (761s left) gem_mmap_gtt (cpuset-big-copy-odd)
[255.092857] Starting subtest: cpuset-big-copy-odd
[269.255945] Subtest cpuset-big-copy-odd: SUCCESS (14.150s)
[269.380923] [017/133] (747s left) core_getstats (basic)
[269.458181] Starting subtest: basic
[269.458899] Subtest basic: SUCCESS (0.000s)
[269.538610] [018/133] (747s left) kms_getfb (getfb-handle-not-fb)
[269.630634] Starting subtest: getfb-handle-not-fb
[269.631367] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[269.724511] [019/133] (746s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[269.813629] Starting subtest: psr-1p-primscrn-spr-indfb-move
[269.815024] Subtest psr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[269.914213] [020/133] (746s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[269.948440] Starting subtest: write-cpu-read-wc-unflushed
[270.026480] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.078s)
[270.115212] [021/133] (746s left) gem_exec_schedule (fairslice)
[270.164150] Starting subtest: fairslice
[270.164859] Starting dynamic subtest: rcs0
[272.186728] Dynamic subtest rcs0: SUCCESS (2.011s)
[272.196633] Starting dynamic subtest: bcs0
[274.198054] Dynamic subtest bcs0: SUCCESS (2.010s)
[274.208136] Starting dynamic subtest: vcs0
[276.209084] Dynamic subtest vcs0: SUCCESS (2.010s)
[276.219200] Starting dynamic subtest: vcs1
[278.220344] Dynamic subtest vcs1: SUCCESS (2.010s)
[278.230601] Starting dynamic subtest: vecs0
[280.231626] Dynamic subtest vecs0: SUCCESS (2.010s)
[280.232466] Subtest fairslice: SUCCESS (10.054s)
[280.532172] [022/133] (736s left) perf (gen12-oa-tlb-invalidate)
[280.618827] Starting subtest: gen12-oa-tlb-invalidate
[280.619532] Starting dynamic subtest: 0-rcs0
[290.688634] Dynamic subtest 0-rcs0: SUCCESS (10.038s)
[290.689434] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.038s)
[290.749799] [023/133] (726s left) gem_exec_fence (parallel)
[290.918709] Starting subtest: parallel
[290.919660] Starting dynamic subtest: rcs0
[293.076948] Dynamic subtest rcs0: SUCCESS (2.149s)
[293.084841] Starting dynamic subtest: bcs0
[295.227719] Dynamic subtest bcs0: SUCCESS (2.150s)
[295.235658] Starting dynamic subtest: vcs0
[297.377877] Dynamic subtest vcs0: SUCCESS (2.150s)
[297.387597] Starting dynamic subtest: vcs1
[299.529265] Dynamic subtest vcs1: SUCCESS (2.150s)
[299.537607] Starting dynamic subtest: vecs0
[301.681465] Dynamic subtest vecs0: SUCCESS (2.152s)
[301.682195] Subtest parallel: SUCCESS (10.754s)
[302.129135] [024/133] (714s left) gem_exec_whisper (basic-contexts-priority)
[302.171343] Starting subtest: basic-contexts-priority
[304.928730] Subtest basic-contexts-priority: SUCCESS (2.748s)
[305.100342] [025/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[305.190539] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[305.191900] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[305.282362] [026/133] (711s left) kms_flip (plain-flip-ts-check-interruptible)
[305.369981] Starting subtest: plain-flip-ts-check-interruptible
[305.372596] Starting dynamic subtest: A-HDMI-A1
[313.206900] Dynamic subtest A-HDMI-A1: SUCCESS (7.814s)
[313.214511] Starting dynamic subtest: B-HDMI-A1
[320.985094] Dynamic subtest B-HDMI-A1: SUCCESS (7.768s)
[320.994774] Starting dynamic subtest: C-HDMI-A1
[328.760069] Dynamic subtest C-HDMI-A1: SUCCESS (7.773s)
[328.769782] Starting dynamic subtest: D-HDMI-A1
[336.511303] Dynamic subtest D-HDMI-A1: SUCCESS (7.772s)
[336.513870] Subtest plain-flip-ts-check-interruptible: SUCCESS (31.137s)
[336.679868] [027/133] (680s left) kms_legacy_colorkey (invalid-plane)
[336.769554] Starting subtest: invalid-plane
[336.770257] Starting dynamic subtest: zero-id
[336.770942] Dynamic subtest zero-id: SUCCESS (0.000s)
[336.778807] Starting dynamic subtest: outrange-id
[336.779489] Dynamic subtest outrange-id: SUCCESS (0.000s)
[336.780163] Subtest invalid-plane: SUCCESS (0.001s)
[336.841546] [028/133] (680s left) kms_content_protection (mei-interface)
[336.930048] Starting subtest: mei-interface
[336.936038] Subtest mei-interface: SKIP (0.004s)
[337.029394] [029/133] (680s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[337.116692] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[337.118029] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[337.201863] [030/133] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[337.288568] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[337.289900] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[337.378324] [031/133] (679s left) kms_pm_dc (dc5-dpms-negative)
[338.469052] Starting subtest: dc5-dpms-negative
[342.720574] Subtest dc5-dpms-negative: SUCCESS (4.216s)
[342.757027] [032/133] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[342.845932] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[342.847347] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[342.939498] [033/133] (674s left) gem_mmap_gtt (flink-race)
[342.972273] Starting subtest: flink-race
[363.083405] Subtest flink-race: SUCCESS (20.081s)
[363.162071] [034/133] (654s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[363.261950] Starting subtest: cursor-rapid-movement-512x512
[363.263338] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[363.348522] [035/133] (654s left) gem_vm_create (isolation)
[363.385342] Starting subtest: isolation
[363.389603] Subtest isolation: SUCCESS (0.004s)
[363.490564] [036/133] (653s left) perf_pmu (semaphore-wait)
[363.526187] Starting subtest: semaphore-wait
[363.526876] Starting dynamic subtest: rcs0
[364.044003] Dynamic subtest rcs0: SUCCESS (0.509s)
[364.054135] Starting dynamic subtest: bcs0
[364.554540] Dynamic subtest bcs0: SUCCESS (0.510s)
[364.564921] Starting dynamic subtest: vcs0
[365.065634] Dynamic subtest vcs0: SUCCESS (0.510s)
[365.075824] Starting dynamic subtest: vcs1
[365.576665] Dynamic subtest vcs1: SUCCESS (0.510s)
[365.586674] Starting dynamic subtest: vecs0
[366.087603] Dynamic subtest vecs0: SUCCESS (0.510s)
[366.088463] Subtest semaphore-wait: SUCCESS (2.554s)
[366.171138] [037/133] (651s left) kms_cursor_crc (cursor-alpha-transparent)
[366.256854] Starting subtest: cursor-alpha-transparent
[366.257554] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.535621] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.277s)
[366.544530] Starting dynamic subtest: pipe-D-HDMI-A-1
[366.781778] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.245s)
[366.782485] Subtest cursor-alpha-transparent: SUCCESS (0.525s)
[366.945625] [038/133] (650s left) gem_exec_params (invalid-bsd2-flag-on-render)
[366.984609] Starting subtest: invalid-bsd2-flag-on-render
[366.985663] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[367.073595] [039/133] (650s left) gem_pwrite (basic-exhaustion)
[367.106513] Starting subtest: basic-exhaustion
[370.523282] Subtest basic-exhaustion: SUCCESS (3.408s)
[370.619256] [040/133] (647s left) syncobj_basic (bad-flags-handle-to-fd)
[370.651835] Starting subtest: bad-flags-handle-to-fd
[370.652501] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[370.715822] [041/133] (646s left) kms_psr (psr-primary-mmap-cpu)
[370.806343] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[370.852128] [042/133] (646s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[370.940456] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[370.941790] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.033346] [043/133] (646s left) i915_hangman (detector)
[371.076464] Starting subtest: detector
[371.077327] Starting dynamic subtest: rcs0
[380.728995] Dynamic subtest rcs0: SUCCESS (9.652s)
[380.746855] Starting dynamic subtest: bcs0
[390.697687] Dynamic subtest bcs0: SUCCESS (9.967s)
[390.713809] Starting dynamic subtest: vcs0
[400.748905] Dynamic subtest vcs0: SUCCESS (10.049s)
[400.765954] Starting dynamic subtest: vcs1
[410.731912] Dynamic subtest vcs1: SUCCESS (9.980s)
[410.750378] Starting dynamic subtest: vecs0
[420.720914] Dynamic subtest vecs0: SUCCESS (9.986s)
[420.721961] Subtest detector: SUCCESS (49.641s)
[420.847045] [044/133] (596s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[420.937724] Starting subtest: plane-lut1d-post-ctm3x4
[421.024425] Starting dynamic subtest: pipe-A-plane-0
[421.115424] Dynamic subtest pipe-A-plane-0: SUCCESS (0.091s)
[421.130863] Starting dynamic subtest: pipe-A-plane-1
[421.206675] Dynamic subtest pipe-A-plane-1: SUCCESS (0.090s)
[421.222730] Starting dynamic subtest: pipe-A-plane-2
[421.298469] Dynamic subtest pipe-A-plane-2: SUCCESS (0.090s)
[421.510466] Starting dynamic subtest: pipe-B-plane-0
[421.592995] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[421.602945] Starting dynamic subtest: pipe-B-plane-1
[421.676578] Dynamic subtest pipe-B-plane-1: SUCCESS (0.082s)
[421.691448] Starting dynamic subtest: pipe-B-plane-2
[421.768218] Dynamic subtest pipe-B-plane-2: SUCCESS (0.090s)
[421.967729] Starting dynamic subtest: pipe-C-plane-0
[422.052494] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s)
[422.060728] Starting dynamic subtest: pipe-C-plane-1
[422.142212] Dynamic subtest pipe-C-plane-1: SUCCESS (0.099s)
[422.156636] Starting dynamic subtest: pipe-C-plane-2
[422.242310] Dynamic subtest pipe-C-plane-2: SUCCESS (0.099s)
[422.440918] Starting dynamic subtest: pipe-D-plane-0
[422.524969] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s)
[422.538912] Starting dynamic subtest: pipe-D-plane-1
[422.616912] Dynamic subtest pipe-D-plane-1: SUCCESS (0.090s)
[422.629864] Starting dynamic subtest: pipe-D-plane-2
[422.716797] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s)
[422.765432] Subtest plane-lut1d-post-ctm3x4: SUCCESS (1.828s)
[422.868928] [045/133] (594s left) gem_flink_basic (double-flink)
[422.903659] Starting subtest: double-flink
[422.904366] Subtest double-flink: SUCCESS (0.000s)
[422.994216] [046/133] (594s left) kms_flip (2x-flip-vs-expired-vblank)
[423.082539] Starting subtest: 2x-flip-vs-expired-vblank
[423.091405] Subtest 2x-flip-vs-expired-vblank: SKIP (0.009s)
[423.161003] [047/133] (594s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[423.198383] Starting subtest: writes-after-reads-uncached
[435.499902] Subtest writes-after-reads-uncached: SUCCESS (12.300s)
[435.607932] [048/133] (582s left) vgem_basic (unload)
[435.641077] Starting subtest: unload
[464.640331] Subtest unload: SUCCESS (28.961s)
[464.695573] [049/133] (553s left) kms_cursor_legacy (single-move)
[464.785582] Starting subtest: single-move
[464.786332] Starting dynamic subtest: pipe-A
[470.199621] Dynamic subtest pipe-A: SUCCESS (5.379s)
[470.207608] Starting dynamic subtest: pipe-B
[475.553949] Dynamic subtest pipe-B: SUCCESS (5.378s)
[475.562076] Starting dynamic subtest: pipe-C
[480.957203] Dynamic subtest pipe-C: SUCCESS (5.379s)
[480.965801] Starting dynamic subtest: pipe-D
[486.335400] Dynamic subtest pipe-D: SUCCESS (5.378s)
[486.343577] Starting dynamic subtest: all-pipes
[491.714946] Dynamic subtest all-pipes: SUCCESS (5.379s)
[491.715729] Subtest single-move: SUCCESS (26.898s)
[491.753272] [050/133] (526s left) kms_addfb_basic (invalid-get-prop)
[491.787396] Starting subtest: invalid-get-prop
[491.788101] Subtest invalid-get-prop: SUCCESS (0.000s)
[491.934290] [051/133] (526s left) kms_psr (psr2-primary-mmap-gtt)
[492.021185] Subtest psr2-primary-mmap-gtt: SKIP (0.000s)
[492.074363] [052/133] (526s left) dmabuf_sync_file (import-multiple-read-write)
[492.114561] Starting subtest: import-multiple-read-write
[492.118934] Subtest import-multiple-read-write: SUCCESS (0.005s)
[492.177476] [053/133] (525s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[492.211853] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[492.212524] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[492.283165] [054/133] (525s left) kms_plane_scaling (planes-scaler-unity-scaling)
[492.369330] Starting subtest: planes-scaler-unity-scaling
[492.370323] Starting dynamic subtest: pipe-A
[492.430073] Dynamic subtest pipe-A: SUCCESS (0.061s)
[492.446191] Starting dynamic subtest: pipe-B
[492.565143] Dynamic subtest pipe-B: SUCCESS (0.134s)
[492.576831] Starting dynamic subtest: pipe-C
[492.698802] Dynamic subtest pipe-C: SUCCESS (0.133s)
[492.709176] Starting dynamic subtest: pipe-D
[492.824156] Dynamic subtest pipe-D: SUCCESS (0.125s)
[492.824888] Subtest planes-scaler-unity-scaling: SUCCESS (0.456s)
[493.009146] [055/133] (525s left) kms_draw_crc (draw-method-mmap-cpu)
[493.099657] Starting subtest: draw-method-mmap-cpu
[493.100377] Starting dynamic subtest: xrgb8888-untiled
[493.249308] Dynamic subtest xrgb8888-untiled: SUCCESS (0.149s)
[493.265735] Starting dynamic subtest: rgb565-untiled
[493.399241] Dynamic subtest rgb565-untiled: SUCCESS (0.148s)
[493.415261] Starting dynamic subtest: xrgb2101010-untiled
[493.532483] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.132s)
[493.547422] Starting dynamic subtest: xbgr16161616f-untiled
[493.682545] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.148s)
[493.697513] Starting dynamic subtest: xrgb8888-xtiled
[493.765989] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.082s)
[493.781766] Starting dynamic subtest: rgb565-xtiled
[493.849227] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[493.864700] Starting dynamic subtest: xrgb2101010-xtiled
[493.924355] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.073s)
[493.939334] Starting dynamic subtest: xbgr16161616f-xtiled
[494.007467] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s)
[494.022379] Starting dynamic subtest: xrgb8888-ytiled
[494.099317] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s)
[494.114772] Starting dynamic subtest: rgb565-ytiled
[494.190789] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s)
[494.206482] Starting dynamic subtest: xrgb2101010-ytiled
[494.274286] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.082s)
[494.289412] Starting dynamic subtest: xbgr16161616f-ytiled
[494.357530] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[494.358514] Subtest draw-method-mmap-cpu: SUCCESS (1.259s)
[494.453112] [056/133] (523s left) gem_ctx_persistence (legacy-engines-queued)
[494.491958] Starting subtest: legacy-engines-queued
[494.492673] Starting dynamic subtest: render
[494.537644] Dynamic subtest render: SUCCESS (0.046s)
[494.554116] Starting dynamic subtest: bsd1
[494.582679] Dynamic subtest bsd1: SUCCESS (0.043s)
[494.600801] Starting dynamic subtest: bsd2
[494.631540] Dynamic subtest bsd2: SUCCESS (0.047s)
[494.648698] Starting dynamic subtest: blt
[494.681640] Dynamic subtest blt: SUCCESS (0.048s)
[494.698785] Starting dynamic subtest: vebox
[494.736499] Dynamic subtest vebox: SUCCESS (0.053s)
[494.737468] Subtest legacy-engines-queued: SUCCESS (0.246s)
[494.808736] [057/133] (523s left) kms_getfb (getfb-handle-closed)
[494.896967] Starting subtest: getfb-handle-closed
[494.897712] Subtest getfb-handle-closed: SUCCESS (0.000s)
[494.996760] [058/133] (523s left) kms_invalid_mode (overflow-vrefresh)
[495.085531] Starting subtest: overflow-vrefresh
[495.086249] Starting dynamic subtest: pipe-A-HDMI-A-1
[495.141301] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.055s)
[495.154128] Starting dynamic subtest: pipe-B-HDMI-A-1
[495.154892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[495.165009] Starting dynamic subtest: pipe-C-HDMI-A-1
[495.165841] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[495.176208] Starting dynamic subtest: pipe-D-HDMI-A-1
[495.176951] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[495.177648] Subtest overflow-vrefresh: SUCCESS (0.064s)
[495.292647] [059/133] (523s left) kms_busy (extended-modeset-hang-oldfb)
[495.386854] Starting subtest: extended-modeset-hang-oldfb
[495.387599] Starting dynamic subtest: pipe-A
[506.187967] Dynamic subtest pipe-A: SUCCESS (10.802s)
[506.202534] Starting dynamic subtest: pipe-D
[516.923950] Dynamic subtest pipe-D: SUCCESS (10.729s)
[516.924712] Subtest extended-modeset-hang-oldfb: SUCCESS (21.540s)
[517.056390] [060/133] (501s left) gem_exec_reloc (basic-write-read-noreloc)
[517.097778] Starting subtest: basic-write-read-noreloc
[517.100215] Subtest basic-write-read-noreloc: SUCCESS (0.002s)
[517.212944] [061/133] (501s left) gem_mmap (basic)
[517.245987] Starting subtest: basic
[517.249469] Subtest basic: SUCCESS (0.000s)
[517.347772] [062/133] (501s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[517.434885] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[517.484720] [063/133] (501s left) syncobj_timeline (wait-all-for-submit-snapshot)
[517.518542] Starting subtest: wait-all-for-submit-snapshot
[517.601267] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[517.675186] [064/133] (500s left) gem_exec_reloc (basic-wc-noreloc)
[517.712225] Starting subtest: basic-wc-noreloc
[517.715144] Subtest basic-wc-noreloc: SUCCESS (0.003s)
[517.829719] [065/133] (500s left) gem_userptr_blits (coherency-unsync)
[517.868321] Subtest coherency-unsync: SKIP (0.000s)
[517.989125] [066/133] (500s left) syncobj_wait (multi-wait-for-submit-signaled)
[518.023299] Starting subtest: multi-wait-for-submit-signaled
[518.023988] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[518.096857] [067/133] (500s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[518.194299] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[518.792961] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.598s)
[518.930736] [068/133] (499s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[518.964576] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[518.965267] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[519.080677] [069/133] (499s left) kms_addfb_basic (bad-pitch-65536)
[519.114370] Starting subtest: bad-pitch-65536
[519.115055] Subtest bad-pitch-65536: SUCCESS (0.000s)
[519.290962] [070/133] (499s left) gem_exec_fence (concurrent)
[519.452151] Starting subtest: concurrent
[519.453163] Starting dynamic subtest: rcs0
[519.483743] Dynamic subtest rcs0: SUCCESS (0.031s)
[519.500969] Starting dynamic subtest: bcs0
[519.519635] Dynamic subtest bcs0: SUCCESS (0.033s)
[519.535199] Starting dynamic subtest: vcs0
[519.554581] Dynamic subtest vcs0: SUCCESS (0.032s)
[519.569874] Starting dynamic subtest: vcs1
[519.589700] Dynamic subtest vcs1: SUCCESS (0.032s)
[519.605270] Starting dynamic subtest: vecs0
[519.625456] Dynamic subtest vecs0: SUCCESS (0.032s)
[519.626555] Subtest concurrent: SUCCESS (0.174s)
[520.081924] [071/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[520.174109] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[520.175526] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[520.256907] [072/133] (498s left) gem_userptr_blits (create-destroy-sync)
[520.302887] Starting subtest: create-destroy-sync
[525.351529] Subtest create-destroy-sync: SUCCESS (5.015s)
[525.420438] [073/133] (493s left) kms_chamelium_frames (hdmi-frame-dump)
[525.561714] Subtest hdmi-frame-dump: SKIP (0.000s)
[525.650753] [074/133] (493s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[525.742654] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[525.744864] Starting dynamic subtest: pipe-A-HDMI-A-1
[525.751869] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[525.764326] Starting dynamic subtest: pipe-B-HDMI-A-1
[525.771140] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[525.782444] Starting dynamic subtest: pipe-C-HDMI-A-1
[525.789220] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[525.797476] Starting dynamic subtest: pipe-D-HDMI-A-1
[525.804244] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[525.805635] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[526.020794] [075/133] (493s left) syncobj_wait (invalid-single-wait-unsubmitted)
[526.054321] Starting subtest: invalid-single-wait-unsubmitted
[526.055028] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[526.112490] [076/133] (493s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[526.200613] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[527.483941] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.283s)
[527.604723] [077/133] (491s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[527.702621] Starting subtest: x-tiled-64bpp-rotate-270
[527.750427] Subtest x-tiled-64bpp-rotate-270: SKIP (0.046s)
[527.855957] [078/133] (491s left) sw_sync (alloc_merge_fence)
[527.888477] Starting subtest: alloc_merge_fence
[527.889182] Subtest alloc_merge_fence: SUCCESS (0.000s)
[527.948120] [079/133] (491s left) syncobj_timeline (etime-multi-wait-all-submitted)
[527.981877] Starting subtest: etime-multi-wait-all-submitted
[528.089937] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s)
[528.165993] [080/133] (491s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[528.255050] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[528.256394] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[528.346694] [081/133] (491s left) i915_pm_rps (reset)
[528.386962] Starting subtest: reset
[532.950788] Subtest reset: SUCCESS (4.533s)
[533.033952] [082/133] (486s left) gem_ctx_sseu (mmap-args)
[533.070400] Subtest mmap-args: SKIP (0.000s)
[533.116843] [083/133] (486s left) i915_query (query-topology-kernel-writes)
[533.152101] Starting subtest: query-topology-kernel-writes
[533.152822] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[533.214684] [084/133] (486s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[533.302583] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[533.351742] [085/133] (486s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[533.456440] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[533.463301] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[533.538612] [086/133] (486s left) gem_spin_batch (spin-all)
[533.580986] Starting subtest: spin-all
[533.589860] Subtest spin-all: SUCCESS (0.010s)
[533.773372] [087/133] (485s left) gem_ccs (block-copy-uncompressed)
[533.811342] Starting subtest: block-copy-uncompressed
[533.813133] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[533.831286] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s)
[533.840931] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[533.849264] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[533.849981] Subtest block-copy-uncompressed: SUCCESS (0.038s)
[533.956745] [088/133] (485s left) kms_properties (crtc-properties-legacy)
[534.044136] Starting subtest: crtc-properties-legacy
[534.045970] Starting dynamic subtest: pipe-A-HDMI-A-1
[534.191666] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s)
[534.201840] Starting dynamic subtest: pipe-B-HDMI-A-1
[534.358596] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.164s)
[534.368245] Starting dynamic subtest: pipe-C-HDMI-A-1
[534.532863] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.172s)
[534.545681] Starting dynamic subtest: pipe-D-HDMI-A-1
[534.700960] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.167s)
[534.701699] Subtest crtc-properties-legacy: SUCCESS (0.658s)
[534.842726] [089/133] (484s left) gem_fence_thrash (bo-write-verify-threaded-y)
[534.878712] Starting subtest: bo-write-verify-threaded-y
[539.332816] Subtest bo-write-verify-threaded-y: SUCCESS (4.421s)
[539.406808] [090/133] (480s left) api_intel_allocator (default-alignment)
[539.444104] Starting subtest: default-alignment
[539.446353] Subtest default-alignment: SUCCESS (0.002s)
[539.563658] [091/133] (480s left) syncobj_timeline (wait-for-submit-snapshot)
[539.598348] Starting subtest: wait-for-submit-snapshot
[539.679974] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[539.752218] [092/133] (480s left) perf_pmu (init-busy)
[539.788111] Starting subtest: init-busy
[539.788835] Starting dynamic subtest: rcs0
[539.789491] Dynamic subtest rcs0: SUCCESS (0.001s)
[539.799199] Starting dynamic subtest: bcs0
[539.799896] Dynamic subtest bcs0: SUCCESS (0.001s)
[539.808960] Starting dynamic subtest: vcs0
[539.809673] Dynamic subtest vcs0: SUCCESS (0.001s)
[539.818095] Starting dynamic subtest: vcs1
[539.818790] Dynamic subtest vcs1: SUCCESS (0.000s)
[539.827318] Starting dynamic subtest: vecs0
[539.827987] Dynamic subtest vecs0: SUCCESS (0.001s)
[539.828722] Subtest init-busy: SUCCESS (0.010s)
[539.861876] [093/133] (480s left) kms_vblank (ts-continuation-dpms-suspend)
[539.950989] Starting subtest: ts-continuation-dpms-suspend
[539.951671] Starting dynamic subtest: pipe-A-HDMI-A-1
[556.453400] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.393s)
[556.468000] Starting dynamic subtest: pipe-D-HDMI-A-1
[573.433670] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.326s)
[573.434376] Subtest ts-continuation-dpms-suspend: SUCCESS (2.728s)
[581.657496] [094/133] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[581.748840] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[581.750170] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[581.853756] [095/133] (446s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[581.887271] Starting subtest: single-wait-all-for-submit-unsubmitted
[581.988720] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[582.054082] [096/133] (445s left) kms_atomic_interruptible (legacy-cursor)
[582.140552] Starting subtest: legacy-cursor
[582.142283] Starting dynamic subtest: pipe-A-HDMI-A-1
[588.372379] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.222s)
[588.373171] Subtest legacy-cursor: SUCCESS (6.224s)
[588.508883] [097/133] (439s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[588.599404] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[588.601524] Starting dynamic subtest: pipe-A-valid-mode
[589.386731] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.785s)
[589.387431] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.787s)
[589.521622] [098/133] (438s left) i915_drm_fdinfo (most-busy-idle-check-all)
[589.559318] Starting subtest: most-busy-idle-check-all
[589.560043] Starting dynamic subtest: rcs0
[590.209395] Dynamic subtest rcs0: SUCCESS (0.649s)
[590.223186] Starting dynamic subtest: bcs0
[590.839061] Dynamic subtest bcs0: SUCCESS (0.627s)
[590.852066] Starting dynamic subtest: vcs0
[591.472064] Dynamic subtest vcs0: SUCCESS (0.630s)
[591.485616] Starting dynamic subtest: vcs1
[592.107344] Dynamic subtest vcs1: SUCCESS (0.633s)
[592.119429] Starting dynamic subtest: vecs0
[592.739416] Dynamic subtest vecs0: SUCCESS (0.629s)
[592.742172] Subtest most-busy-idle-check-all: SUCCESS (3.179s)
[592.812368] [099/133] (435s left) kms_big_fb (linear-16bpp-rotate-180)
[592.908179] Starting subtest: linear-16bpp-rotate-180
[594.111648] Subtest linear-16bpp-rotate-180: SUCCESS (1.202s)
[594.243125] [100/133] (433s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[594.340175] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[594.341539] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[594.421132] [101/133] (433s left) kms_atomic (plane-cursor-legacy)
[594.508306] Starting subtest: plane-cursor-legacy
[594.508989] Starting dynamic subtest: pipe-A-HDMI-A-1
[594.647114] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.138s)
[594.648977] Subtest plane-cursor-legacy: SUCCESS (0.141s)
[594.772107] [102/133] (433s left) gem_ctx_engines (invalid-engines)
[594.817284] Starting subtest: invalid-engines
[594.822056] Subtest invalid-engines: SUCCESS (0.005s)
[595.001767] [103/133] (433s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[595.087367] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[595.088071] Starting dynamic subtest: pipe-A-HDMI-A-1
[595.105459] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[595.114030] Starting dynamic subtest: pipe-B-HDMI-A-1
[595.131369] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[595.139842] Starting dynamic subtest: pipe-C-HDMI-A-1
[595.156404] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[595.167082] Starting dynamic subtest: pipe-D-HDMI-A-1
[595.191943] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[595.193409] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.016s)
[595.345892] [104/133] (433s left) gem_exec_parallel (basic)
[595.389401] Starting subtest: basic
[595.390113] Starting dynamic subtest: rcs0
[597.222385] Dynamic subtest rcs0: SUCCESS (1.832s)
[597.233688] Starting dynamic subtest: bcs0
[598.959732] Dynamic subtest bcs0: SUCCESS (1.733s)
[598.968197] Starting dynamic subtest: vcs0
[600.684553] Dynamic subtest vcs0: SUCCESS (1.725s)
[600.694865] Starting dynamic subtest: vcs1
[602.498566] Dynamic subtest vcs1: SUCCESS (1.812s)
[602.508316] Starting dynamic subtest: vecs0
[604.225543] Dynamic subtest vecs0: SUCCESS (1.725s)
[604.226298] Subtest basic: SUCCESS (8.833s)
[604.405705] [105/133] (424s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[604.497348] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[604.498730] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[604.581899] [106/133] (423s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[604.670901] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[604.672244] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[604.757173] [107/133] (423s left) i915_pm_rps (thresholds)
[604.794147] Starting subtest: thresholds
[604.794880] Starting dynamic subtest: gt0
[614.863070] Dynamic subtest gt0: SUCCESS (10.066s)
[614.864165] Subtest thresholds: SUCCESS (10.068s)
[614.933618] [108/133] (413s left) gem_exec_schedule (pi-common)
[615.096220] Starting subtest: pi-common
[615.097171] Starting dynamic subtest: rcs0
[615.134582] Dynamic subtest rcs0: SUCCESS (0.040s)
[615.147338] Starting dynamic subtest: bcs0
[615.170730] Dynamic subtest bcs0: SUCCESS (0.035s)
[615.184037] Starting dynamic subtest: vcs0
[615.200447] Dynamic subtest vcs0: SUCCESS (0.028s)
[615.215022] Starting dynamic subtest: vcs1
[615.229092] Dynamic subtest vcs1: SUCCESS (0.027s)
[615.242327] Starting dynamic subtest: vecs0
[615.255655] Dynamic subtest vecs0: SUCCESS (0.025s)
[615.256439] Subtest pi-common: SUCCESS (0.163s)
[615.432268] [109/133] (413s left) kms_big_fb (4-tiled-addfb-size-overflow)
[615.527101] Starting subtest: 4-tiled-addfb-size-overflow
[615.528482] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[615.620825] [110/133] (412s left) prime_self_import (reimport-vs-gem_close-race)
[615.653532] Starting subtest: reimport-vs-gem_close-race
[620.695215] Subtest reimport-vs-gem_close-race: SUCCESS (5.037s)
[620.797359] [111/133] (407s left) kms_cursor_edge_walk (256x256-left-edge)
[620.887025] Starting subtest: 256x256-left-edge
[620.888809] Starting dynamic subtest: pipe-A-HDMI-A-1
[622.656015] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.768s)
[622.667985] Starting dynamic subtest: pipe-D-HDMI-A-1
[624.352749] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.693s)
[624.353530] Subtest 256x256-left-edge: SUCCESS (3.466s)
[624.458991] [112/133] (404s left) kms_prop_blob (invalid-get-prop-any)
[624.496348] Starting subtest: invalid-get-prop-any
[624.497042] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[624.557866] [113/133] (404s left) kms_universal_plane (universal-plane-sanity)
[624.645002] Starting subtest: universal-plane-sanity
[624.646801] Starting dynamic subtest: pipe-A-HDMI-A-1
[624.936473] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.290s)
[624.950365] Starting dynamic subtest: pipe-B-HDMI-A-1
[625.185255] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.246s)
[625.198918] Starting dynamic subtest: pipe-C-HDMI-A-1
[625.439679] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.252s)
[625.449417] Starting dynamic subtest: pipe-D-HDMI-A-1
[625.680031] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.238s)
[625.681967] Subtest universal-plane-sanity: SUCCESS (1.036s)
[625.795468] [114/133] (403s left) gem_lmem_swapping (heavy-random)
[625.832719] Subtest heavy-random: SKIP (0.000s)
[625.873904] [115/133] (402s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[625.960981] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[625.962314] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[626.115685] [116/133] (402s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[626.208892] Starting subtest: y-tiled-32bpp-rotate-270
[627.504900] Subtest y-tiled-32bpp-rotate-270: SUCCESS (1.295s)
[627.626083] [117/133] (401s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[627.713947] Starting subtest: cursorB-vs-flipB-atomic-transitions
[627.715408] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[627.774269] [118/133] (401s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[627.859164] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[627.879627] Starting dynamic subtest: pipe-A-plane-0
[628.087758] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[628.104794] Starting dynamic subtest: pipe-A-plane-3
[628.254547] Dynamic subtest pipe-A-plane-3: SUCCESS (0.165s)
[628.269554] Starting dynamic subtest: pipe-A-plane-5
[628.421301] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[628.560046] Starting dynamic subtest: pipe-B-plane-0
[628.718252] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[628.732371] Starting dynamic subtest: pipe-B-plane-3
[628.885035] Dynamic subtest pipe-B-plane-3: SUCCESS (0.165s)
[628.901545] Starting dynamic subtest: pipe-B-plane-5
[629.051613] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[629.125075] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SUCCESS (1.265s)
[629.273608] [119/133] (399s left) kms_psr (pr-primary-mmap-gtt)
[629.366778] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[629.408629] [120/133] (399s left) kms_async_flips (async-flip-dpms)
[629.494122] Starting subtest: async-flip-dpms
[629.626653] Starting dynamic subtest: pipe-A-HDMI-A-1
[632.061863] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.433s)
[632.218695] Starting dynamic subtest: pipe-B-HDMI-A-1
[634.609684] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.402s)
[634.767268] Starting dynamic subtest: pipe-C-HDMI-A-1
[637.185356] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.426s)
[637.346180] Starting dynamic subtest: pipe-D-HDMI-A-1
[639.755458] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.418s)
[639.757314] Subtest async-flip-dpms: SUCCESS (10.261s)
[639.990678] [121/133] (389s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[640.080363] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[640.126948] [122/133] (388s left) perf_pmu (frequency)
[640.162608] Starting subtest: frequency
[640.164390] Starting dynamic subtest: gt0
[642.279787] Dynamic subtest gt0: SUCCESS (2.113s)
[642.290983] Starting dynamic subtest: idle-gt0
[642.793298] Dynamic subtest idle-gt0: SUCCESS (0.504s)
[642.793993] Subtest frequency: SUCCESS (2.623s)
[642.855655] [123/133] (386s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[642.943119] Starting subtest: flip-vs-cursor-busy-crc-atomic
[643.337986] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.395s)
[643.485067] [124/133] (385s left) kms_chamelium_color (ctm-0-50)
[643.573788] Subtest ctm-0-50: SKIP (0.000s)
[643.619314] [125/133] (385s left) kms_chamelium_hpd (vga-hpd)
[643.762477] Subtest vga-hpd: SKIP (0.000s)
[643.853624] [126/133] (385s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[643.947984] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[643.968163] Starting dynamic subtest: pipe-A-plane-0
[644.176359] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s)
[644.192597] Starting dynamic subtest: pipe-A-plane-3
[644.342977] Dynamic subtest pipe-A-plane-3: SUCCESS (0.164s)
[644.357453] Starting dynamic subtest: pipe-A-plane-5
[644.509772] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s)
[644.667669] Starting dynamic subtest: pipe-B-plane-0
[644.825878] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[644.843880] Starting dynamic subtest: pipe-B-plane-3
[644.992538] Dynamic subtest pipe-B-plane-3: SUCCESS (0.164s)
[645.009089] Starting dynamic subtest: pipe-B-plane-5
[645.159283] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s)
[645.232539] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.284s)
[645.408527] [127/133] (383s left) kms_pm_rpm (pm-caching)
[646.806202] Starting subtest: pm-caching
[652.891475] Subtest pm-caching: SUCCESS (6.082s)
[653.034877] [128/133] (376s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[653.122214] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[653.123556] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[653.187972] [129/133] (376s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[653.278376] Starting subtest: fbcpsr-tiling-y
[653.279816] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[653.363798] [130/133] (376s left) gem_workarounds (suspend-resume-fd)
[653.410905] Starting subtest: suspend-resume-fd
[669.392639] Subtest suspend-resume-fd: SUCCESS (1.185s)
[678.524119] [131/133] (359s left) gem_ctx_isolation (preservation-reset)
[678.681996] Starting subtest: preservation-reset
[678.682991] Starting dynamic subtest: rcs0
[678.802779] Dynamic subtest rcs0: SUCCESS (0.129s)
[678.812618] Starting dynamic subtest: bcs0
[678.957230] Dynamic subtest bcs0: SUCCESS (0.153s)
[678.967232] Starting dynamic subtest: vcs0
[679.117201] Dynamic subtest vcs0: SUCCESS (0.159s)
[679.127209] Starting dynamic subtest: vcs1
[679.282515] Dynamic subtest vcs1: SUCCESS (0.164s)
[679.292528] Starting dynamic subtest: vecs0
[679.452905] Dynamic subtest vecs0: SUCCESS (0.169s)
[679.454051] Subtest preservation-reset: SUCCESS (0.779s)
[679.555221] [132/133] (358s left) gem_exec_schedule (semaphore-codependency)
[679.601071] Starting subtest: semaphore-codependency
[679.607979] Subtest semaphore-codependency: SUCCESS (0.007s)
[679.902008] [133/133] (358s left) gen9_exec_parse (bb-chained)
[679.939876] Subtest bb-chained: SKIP (0.000s)
[679.982941] Closing watchdogs
results: parsing output: 0/ for test: gem_ringfill
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_pipe_b_c_ivb
results: parsing output: 13/ for test: kms_pipe_crc_basic
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: core_getstats
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_exec_whisper
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_legacy_colorkey
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_pm_dc
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: gem_vm_create
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: gem_pwrite
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: kms_color_pipeline
results: parsing output: 44/ for test: gem_flink_basic
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_partial_pwrite_pread
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: kms_addfb_basic
results: parsing output: 50/ for test: kms_psr
results: parsing output: 51/ for test: dmabuf_sync_file
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_draw_crc
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_getfb
results: parsing output: 57/ for test: kms_invalid_mode
results: parsing output: 58/ for test: kms_busy
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: gem_mmap
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: gem_userptr_blits
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_chamelium_frames
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_big_fb
results: parsing output: 77/ for test: sw_sync
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: i915_pm_rps
results: parsing output: 81/ for test: gem_ctx_sseu
results: parsing output: 82/ for test: i915_query
results: parsing output: 83/ for test: kms_psr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_spin_batch
results: parsing output: 86/ for test: gem_ccs
results: parsing output: 87/ for test: kms_properties
results: parsing output: 88/ for test: gem_fence_thrash
results: parsing output: 89/ for test: api_intel_allocator
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_atomic_interruptible
results: parsing output: 96/ for test: kms_flip_scaled_crc
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_atomic
results: parsing output: 101/ for test: gem_ctx_engines
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_exec_parallel
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_pm_rps
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: prime_self_import
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: kms_prop_blob
results: parsing output: 112/ for test: kms_universal_plane
results: parsing output: 113/ for test: gem_lmem_swapping
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_async_flips
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: perf_pmu
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: kms_chamelium_color
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_plane
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_plane
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_workarounds
results: parsing output: 130/ for test: gem_ctx_isolation
results: parsing output: 131/ for test: gem_exec_schedule
results: parsing output: 132/ for test: gen9_exec_parse
Done.