[43.812670] Initializing watchdogs [43.812731] /dev/watchdog0 [43.828348] [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] [43.833773] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [43.836748] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [43.838607] [001/134] (960s left) api_intel_allocator (reopen-fork) [43.874873] Starting subtest: reopen-fork [47.313299] Subtest reopen-fork: SUCCESS (3.418s) [47.380550] [002/134] (956s left) gen9_exec_parse (unaligned-jump) [47.420471] Subtest unaligned-jump: SKIP (0.000s) [47.462694] [003/134] (956s left) i915_pm_rc6_residency (rc6-accuracy) [47.494540] Starting subtest: rc6-accuracy [47.495283] Starting dynamic subtest: gt0 [50.673622] Dynamic subtest gt0: SUCCESS (3.134s) [50.674620] Subtest rc6-accuracy: SUCCESS (3.135s) [50.749646] [004/134] (953s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [50.840581] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [50.842027] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [50.942644] [005/134] (953s left) gem_exec_reloc (basic-cpu-gtt-active) [50.981507] Starting subtest: basic-cpu-gtt-active [51.116187] Subtest basic-cpu-gtt-active: SUCCESS (0.125s) [51.247797] [006/134] (953s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [51.331719] Starting subtest: plane-scaler-unity-scaling-with-modifiers [51.333040] Starting dynamic subtest: pipe-A [51.730389] Dynamic subtest pipe-A: SUCCESS (0.396s) [51.737826] Starting dynamic subtest: pipe-B [52.167764] Dynamic subtest pipe-B: SUCCESS (0.434s) [52.175152] Starting dynamic subtest: pipe-C [52.604426] Dynamic subtest pipe-C: SUCCESS (0.433s) [52.609810] Starting dynamic subtest: pipe-D [53.043799] Dynamic subtest pipe-D: SUCCESS (0.436s) [53.044585] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.700s) [53.241678] [007/134] (951s left) kms_plane_cursor (overlay) [53.329644] Starting subtest: overlay [53.331106] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [54.720233] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.381s) [54.763175] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [56.126935] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.367s) [56.171198] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [57.541139] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.375s) [57.629317] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [59.031987] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.403s) [59.066975] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [60.436598] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.376s) [60.467527] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [61.839323] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.375s) [61.911407] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [63.339759] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.430s) [63.371921] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [64.775570] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.409s) [64.806269] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [66.227486] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.425s) [66.308374] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [67.585062] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.282s) [67.615333] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [68.953643] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.342s) [68.985993] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [70.397197] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.417s) [70.463719] Subtest overlay: SUCCESS (17.092s) [70.580708] [008/134] (934s left) sw_sync (alloc_fence) [70.618249] Starting subtest: alloc_fence [70.618969] Subtest alloc_fence: SUCCESS (0.000s) [70.690092] [009/134] (933s left) gen9_exec_parse (batch-invalid-length) [70.724726] Subtest batch-invalid-length: SKIP (0.000s) [70.757945] [010/134] (933s left) gem_mmap_offset (blt-coherency) [70.790603] Starting subtest: blt-coherency [70.796548] Subtest blt-coherency: SUCCESS (0.006s) [70.919864] [011/134] (933s left) kms_psr (pr-primary-page-flip) [71.008716] Subtest pr-primary-page-flip: SKIP (0.000s) [71.042968] [012/134] (933s left) kms_vblank (query-busy-hang) [71.126475] Starting subtest: query-busy-hang [71.127189] Starting dynamic subtest: pipe-A-HDMI-A-1 [84.624573] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.492s) [84.632838] Starting dynamic subtest: pipe-D-HDMI-A-1 [98.442350] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.813s) [98.443107] Subtest query-busy-hang: SUCCESS (27.312s) [98.629527] [013/134] (906s left) gem_softpin (allocator-evict) [98.668407] Starting subtest: allocator-evict [98.669102] Starting dynamic subtest: rcs0 [122.206173] Dynamic subtest rcs0: SUCCESS (23.536s) [122.213902] Starting dynamic subtest: bcs0 [145.155162] Dynamic subtest bcs0: SUCCESS (22.948s) [145.162093] Starting dynamic subtest: vcs0 [168.470265] Dynamic subtest vcs0: SUCCESS (23.316s) [168.476909] Starting dynamic subtest: vcs1 [191.710145] Dynamic subtest vcs1: SUCCESS (23.240s) [191.716138] Starting dynamic subtest: vecs0 [215.054995] Dynamic subtest vecs0: SUCCESS (23.344s) [215.055727] Subtest allocator-evict: SUCCESS (116.387s) [215.128140] [014/134] (789s left) kms_chamelium_color (ctm-max) [215.262377] Subtest ctm-max: SKIP (0.000s) [215.298322] [015/134] (789s left) syncobj_timeline (single-wait-signaled) [215.336671] Starting subtest: single-wait-signaled [215.337370] Subtest single-wait-signaled: SUCCESS (0.001s) [215.425248] [016/134] (789s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [215.514407] Starting subtest: fbc-shrfb-scaledprimary [218.363875] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.849s) [218.491507] [017/134] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [218.583255] Starting subtest: psr-2p-scndscrn-spr-indfb-move [218.584588] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [218.693045] [018/134] (786s left) prime_mmap (test_correct_cpu_write) [218.726398] Starting subtest: test_correct_cpu_write [218.727092] Starting dynamic subtest: test_correct_cpu_write-smem [218.727769] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [218.728506] Subtest test_correct_cpu_write: SUCCESS (0.001s) [218.852067] [019/134] (786s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [218.941646] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [220.032944] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.092s) [220.175769] [020/134] (784s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [220.215117] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [220.215840] Starting dynamic subtest: smem [220.292286] Dynamic subtest smem: SUCCESS (0.078s) [220.293027] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.079s) [220.463481] [021/134] (784s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [220.553531] Starting subtest: basic-flip-after-cursor-atomic [221.097286] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.543s) [221.237064] [022/134] (783s left) gem_ctx_create (basic-files) [221.281451] Starting subtest: basic-files [223.291648] Subtest basic-files: SUCCESS (2.010s) [223.480994] [023/134] (781s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [223.569321] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [223.570701] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [223.650483] [024/134] (781s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [223.739415] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [223.740848] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [223.831213] [025/134] (781s left) syncobj_basic (bad-flags-fd-to-handle) [223.863266] Starting subtest: bad-flags-fd-to-handle [223.863957] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [223.945847] [026/134] (781s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [223.977849] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [224.087267] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s) [224.165264] [027/134] (781s left) kms_pm_dc (dc6-dpms) [225.259085] Starting subtest: dc6-dpms [228.615928] Subtest dc6-dpms: FAIL (3.343s) [228.710200] [028/134] (776s left) gem_exec_reloc (basic-write-gtt-noreloc) [228.748090] Starting subtest: basic-write-gtt-noreloc [228.751129] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s) [228.869154] [029/134] (776s left) kms_big_fb (y-tiled-64bpp-rotate-270) [228.964794] Starting subtest: y-tiled-64bpp-rotate-270 [229.009814] Subtest y-tiled-64bpp-rotate-270: SKIP (0.044s) [229.139725] [030/134] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [229.232559] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [229.233919] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [229.335675] [031/134] (776s left) kms_content_protection (content-type-change) [229.424139] Starting subtest: content-type-change [229.438938] Subtest content-type-change: SKIP (0.013s) [229.541165] [032/134] (775s left) kms_cursor_crc (cursor-sliding-32x32) [229.627523] Starting subtest: cursor-sliding-32x32 [229.683634] Subtest cursor-sliding-32x32: SKIP (0.055s) [229.792092] [033/134] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [229.881698] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [229.883016] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [229.990570] [034/134] (775s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [230.075711] Starting subtest: short-flip-after-cursor-atomic-transitions [230.586313] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.511s) [230.724322] [035/134] (774s left) gem_ctx_shared (disjoint-timelines) [230.767400] Starting subtest: disjoint-timelines [230.815322] Subtest disjoint-timelines: SUCCESS (0.048s) [231.074663] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [231.077390] [036/134] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [231.166416] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [231.167785] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [231.263420] [037/134] (774s left) prime_busy (hang) [231.299080] Starting subtest: hang [231.299810] Starting dynamic subtest: rcs0 [245.882155] Dynamic subtest rcs0: SUCCESS (14.548s) [245.887742] Starting dynamic subtest: bcs0 [252.602186] Dynamic subtest bcs0: SUCCESS (6.719s) [252.607824] Starting dynamic subtest: vcs0 [259.578036] Dynamic subtest vcs0: SUCCESS (6.975s) [259.585102] Starting dynamic subtest: vcs1 [266.619274] Dynamic subtest vcs1: SUCCESS (7.039s) [266.626296] Starting dynamic subtest: vecs0 [273.568749] Dynamic subtest vecs0: SUCCESS (6.975s) [273.569432] Subtest hang: SUCCESS (42.261s) [273.685888] [038/134] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [273.776659] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [273.777977] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [273.879583] [039/134] (731s left) sysfs_preempt_timeout (timeout) [273.914837] Starting subtest: timeout [273.915535] Starting dynamic subtest: vecs0 [274.890578] Dynamic subtest vecs0: SUCCESS (0.975s) [274.901098] Starting dynamic subtest: vcs0 [275.821656] Dynamic subtest vcs0: SUCCESS (0.929s) [275.833016] Starting dynamic subtest: bcs0 [276.768561] Dynamic subtest bcs0: SUCCESS (0.945s) [276.780167] Starting dynamic subtest: rcs0 [277.698498] Dynamic subtest rcs0: SUCCESS (0.928s) [277.707664] Starting dynamic subtest: vcs1 [278.656707] Dynamic subtest vcs1: SUCCESS (0.956s) [278.657921] Subtest timeout: SUCCESS (4.743s) [278.741285] [040/134] (727s left) gem_pwrite (basic-random) [278.773984] Starting subtest: basic-random [284.284333] Subtest basic-random: SUCCESS (5.474s) [284.366585] [041/134] (721s left) kms_vblank (ts-continuation-dpms-rpm) [284.501595] Starting subtest: ts-continuation-dpms-rpm [284.502279] Starting dynamic subtest: pipe-A-HDMI-A-1 [286.056918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.554s) [286.068281] Starting dynamic subtest: pipe-D-HDMI-A-1 [287.272576] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.211s) [287.273274] Subtest ts-continuation-dpms-rpm: SUCCESS (2.771s) [287.419964] [042/134] (718s left) kms_chamelium_hpd (vga-hpd-without-ddc) [287.563095] Subtest vga-hpd-without-ddc: SKIP (0.000s) [287.668607] [043/134] (718s left) prime_self_import (basic-with_one_bo_two_files) [287.705454] Starting subtest: basic-with_one_bo_two_files [287.707804] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [287.816521] [044/134] (718s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [287.902909] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [287.904548] Starting dynamic subtest: pipe-A-valid-mode [288.736948] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.832s) [288.737662] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.834s) [288.885779] [045/134] (717s left) gem_exec_reloc (basic-gtt) [288.925374] Starting subtest: basic-gtt [288.931724] Subtest basic-gtt: SUCCESS (0.006s) [289.052304] [046/134] (716s left) kms_big_fb (linear-32bpp-rotate-0) [289.158849] Starting subtest: linear-32bpp-rotate-0 [290.700778] Subtest linear-32bpp-rotate-0: SUCCESS (1.542s) [290.866543] [047/134] (715s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [290.953778] Starting subtest: basic-max-pipe-crc-check [290.955223] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [290.997220] [048/134] (715s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [291.087543] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [291.122125] [049/134] (714s left) drm_read (short-buffer-block) [291.225805] Starting subtest: short-buffer-block [291.226504] Subtest short-buffer-block: SUCCESS (0.000s) [291.358738] [050/134] (714s left) gem_ctx_persistence (many-contexts) [291.395612] Starting subtest: many-contexts [330.500153] Subtest many-contexts: SUCCESS (39.104s) [330.580936] [051/134] (675s left) prime_mmap (test_correct) [330.615392] Starting subtest: test_correct [330.616069] Starting dynamic subtest: test_correct-smem [330.619014] Dynamic subtest test_correct-smem: SUCCESS (0.003s) [330.619712] Subtest test_correct: SUCCESS (0.004s) [330.730488] [052/134] (675s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [330.770803] Starting subtest: invalid-multi-wait-all-unsubmitted [330.771517] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [330.864409] [053/134] (675s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [330.960763] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [331.639734] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.679s) [331.796233] [054/134] (674s left) gem_mmap_gtt (basic-copy) [331.829598] Starting subtest: basic-copy [332.308335] Subtest basic-copy: SUCCESS (0.471s) [332.382826] [055/134] (673s left) gem_exec_suspend (basic) [332.423345] Starting subtest: basic [332.424076] Starting dynamic subtest: smem [332.905876] Dynamic subtest smem: SUCCESS (0.482s) [332.906587] Subtest basic: SUCCESS (0.483s) [333.096855] [056/134] (673s left) perf_pmu (busy-accuracy-2) [333.132418] Starting subtest: busy-accuracy-2 [333.133130] Starting dynamic subtest: rcs0 [336.169879] Dynamic subtest rcs0: SUCCESS (3.034s) [336.177880] Starting dynamic subtest: bcs0 [339.200887] Dynamic subtest bcs0: SUCCESS (3.031s) [339.209417] Starting dynamic subtest: vcs0 [342.230847] Dynamic subtest vcs0: SUCCESS (3.029s) [342.239591] Starting dynamic subtest: vcs1 [345.264347] Dynamic subtest vcs1: SUCCESS (3.032s) [345.273364] Starting dynamic subtest: vecs0 [348.295663] Dynamic subtest vecs0: SUCCESS (3.031s) [348.296731] Subtest busy-accuracy-2: SUCCESS (15.161s) [348.382080] [057/134] (658s left) gem_wait (await) [348.426458] Starting subtest: await [348.427179] Starting dynamic subtest: all-engines [349.482444] Dynamic subtest all-engines: SUCCESS (1.056s) [349.489786] Starting dynamic subtest: rcs0 [350.522579] Dynamic subtest rcs0: SUCCESS (1.039s) [350.533916] Starting dynamic subtest: bcs0 [351.564382] Dynamic subtest bcs0: SUCCESS (1.040s) [351.573924] Starting dynamic subtest: vcs0 [352.593259] Dynamic subtest vcs0: SUCCESS (1.027s) [352.603979] Starting dynamic subtest: vcs1 [353.625462] Dynamic subtest vcs1: SUCCESS (1.030s) [353.635753] Starting dynamic subtest: vecs0 [354.659320] Dynamic subtest vecs0: SUCCESS (1.032s) [354.660223] Subtest await: SUCCESS (6.234s) [354.861185] [058/134] (651s left) prime_mmap (test_refcounting) [354.895080] Starting subtest: test_refcounting [354.895805] Starting dynamic subtest: test_refcounting-smem [354.896530] Dynamic subtest test_refcounting-smem: SUCCESS (0.002s) [354.897259] Subtest test_refcounting: SUCCESS (0.003s) [355.016380] [059/134] (651s left) gem_exec_balancer (individual) [355.056171] Starting subtest: individual [356.576309] Subtest individual: SUCCESS (1.511s) [356.761818] [060/134] (649s left) kms_dp_link_training (uhbr-sst) [356.851773] Starting subtest: uhbr-sst [356.853202] Subtest uhbr-sst: SKIP (0.000s) [356.939682] [061/134] (649s left) gem_busy (busy) [356.980424] Starting subtest: busy [356.981122] Starting dynamic subtest: all-engines [357.007635] Dynamic subtest all-engines: SUCCESS (0.027s) [357.014599] Starting dynamic subtest: rcs0 [357.025542] Dynamic subtest rcs0: SUCCESS (0.017s) [357.033977] Starting dynamic subtest: bcs0 [357.046592] Dynamic subtest bcs0: SUCCESS (0.020s) [357.059765] Starting dynamic subtest: vcs0 [357.075247] Dynamic subtest vcs0: SUCCESS (0.027s) [357.089587] Starting dynamic subtest: vcs1 [357.108393] Dynamic subtest vcs1: SUCCESS (0.031s) [357.123084] Starting dynamic subtest: vecs0 [357.126202] Dynamic subtest vecs0: SUCCESS (0.017s) [357.126898] Subtest busy: SUCCESS (0.146s) [357.502536] [062/134] (649s left) kms_big_fb (4-tiled-8bpp-rotate-180) [357.596120] Starting subtest: 4-tiled-8bpp-rotate-180 [357.597457] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s) [357.700870] [063/134] (648s left) kms_cursor_crc (cursor-rapid-movement-128x42) [357.792859] Starting subtest: cursor-rapid-movement-128x42 [357.798707] Starting dynamic subtest: pipe-A-HDMI-A-1 [358.051120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.253s) [358.085983] Starting dynamic subtest: pipe-D-HDMI-A-1 [358.287179] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.208s) [358.287903] Subtest cursor-rapid-movement-128x42: SUCCESS (0.495s) [358.437239] [064/134] (648s left) kms_joiner (invalid-modeset-force-big-joiner) [358.527894] Starting subtest: invalid-modeset-force-big-joiner [358.529286] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [358.591631] [065/134] (648s left) kms_flip (dpms-off-confusion-interruptible) [358.681696] Starting subtest: dpms-off-confusion-interruptible [358.684451] Starting dynamic subtest: A-HDMI-A1 [366.366703] Dynamic subtest A-HDMI-A1: SUCCESS (7.663s) [366.374074] Starting dynamic subtest: B-HDMI-A1 [374.012437] Dynamic subtest B-HDMI-A1: SUCCESS (7.635s) [374.019298] Starting dynamic subtest: C-HDMI-A1 [381.664920] Dynamic subtest C-HDMI-A1: SUCCESS (7.650s) [381.671844] Starting dynamic subtest: D-HDMI-A1 [389.316503] Dynamic subtest D-HDMI-A1: SUCCESS (7.648s) [389.317244] Subtest dpms-off-confusion-interruptible: SUCCESS (30.609s) [389.451352] [066/134] (617s left) perf_pmu (pmu-read) [389.487283] Starting subtest: pmu-read [389.490141] Subtest pmu-read: SUCCESS (0.003s) [389.562942] [067/134] (617s left) gem_lmem_swapping (random) [389.598882] Subtest random: SKIP (0.000s) [389.645008] [068/134] (617s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [389.732782] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [389.734116] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [389.904519] [069/134] (617s left) gem_exec_schedule (u-semaphore-user) [389.948521] Starting subtest: u-semaphore-user [389.955757] Subtest u-semaphore-user: SUCCESS (0.007s) [390.270143] [070/134] (616s left) gem_workarounds (basic-read) [390.314822] Starting subtest: basic-read [390.321955] Subtest basic-read: SUCCESS (0.007s) [390.441629] [071/134] (616s left) kms_hdr (bpc-switch-suspend) [390.527939] Starting subtest: bpc-switch-suspend [390.529972] Subtest bpc-switch-suspend: SKIP (0.001s) [390.593314] [072/134] (616s left) kms_prime (d3hot) [390.689834] Subtest D3hot: SKIP (0.000s) [390.775094] [073/134] (616s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [390.859340] Starting subtest: bad-rotation-90-yf-tiled-ccs [390.861403] Starting dynamic subtest: pipe-A-HDMI-A-1 [390.868200] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [390.877120] Starting dynamic subtest: pipe-B-HDMI-A-1 [390.883904] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [390.892654] Starting dynamic subtest: pipe-C-HDMI-A-1 [390.899392] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [390.907811] Starting dynamic subtest: pipe-D-HDMI-A-1 [390.915008] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [390.916382] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s) [391.096417] [074/134] (616s left) gem_exec_endless (dispatch) [391.145623] Starting subtest: dispatch [391.146447] Starting dynamic subtest: rcs0 [391.149916] Dynamic subtest rcs0: SUCCESS (0.004s) [391.158471] Starting dynamic subtest: bcs0 [391.159845] Dynamic subtest bcs0: SUCCESS (0.004s) [391.167203] Starting dynamic subtest: vcs0 [391.168557] Dynamic subtest vcs0: SUCCESS (0.004s) [391.176041] Starting dynamic subtest: vcs1 [391.177381] Dynamic subtest vcs1: SUCCESS (0.003s) [391.184009] Starting dynamic subtest: vecs0 [391.185348] Dynamic subtest vecs0: SUCCESS (0.004s) [391.186049] Subtest dispatch: SUCCESS (0.024s) [391.319283] [075/134] (615s left) kms_async_flips (test-time-stamp-atomic) [391.405943] Starting subtest: test-time-stamp-atomic [391.524121] Starting dynamic subtest: pipe-A-HDMI-A-1 [391.631602] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.108s) [391.772360] Starting dynamic subtest: pipe-B-HDMI-A-1 [391.856453] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.090s) [391.979539] Starting dynamic subtest: pipe-C-HDMI-A-1 [392.076365] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.103s) [392.208978] Starting dynamic subtest: pipe-D-HDMI-A-1 [392.296929] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.095s) [392.297722] Subtest test-time-stamp-atomic: SUCCESS (0.891s) [392.550933] [076/134] (614s left) dmabuf_sync_file (export-wait-after-attach) [392.588403] Starting subtest: export-wait-after-attach [392.589128] Subtest export-wait-after-attach: SUCCESS (0.001s) [392.668127] [077/134] (614s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [392.756307] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [392.771082] Starting dynamic subtest: pipe-A-plane-0 [392.772526] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [392.781402] Starting dynamic subtest: pipe-A-plane-3 [392.782866] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [392.791638] Starting dynamic subtest: pipe-A-plane-5 [392.793116] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [392.801630] Starting dynamic subtest: pipe-A-plane-7 [392.803072] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [392.931331] Starting dynamic subtest: pipe-B-plane-0 [392.932758] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [392.939816] Starting dynamic subtest: pipe-B-plane-3 [392.941168] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [392.948304] Starting dynamic subtest: pipe-B-plane-5 [392.949664] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [392.956483] Starting dynamic subtest: pipe-B-plane-7 [392.957793] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [392.973716] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.216s) [393.113754] [078/134] (614s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs) [393.199969] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs [393.201292] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s) [393.385632] [079/134] (613s left) kms_flip (2x-flip-vs-panning-vs-hang) [393.473796] Starting subtest: 2x-flip-vs-panning-vs-hang [393.482475] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.009s) [393.571233] [080/134] (613s left) gem_mmap_gtt (basic-small-copy-xy) [393.603864] Starting subtest: basic-small-copy-XY [396.197487] Subtest basic-small-copy-XY: SUCCESS (2.594s) [396.270853] [081/134] (611s left) kms_cursor_crc (cursor-dpms) [396.411823] Starting subtest: cursor-dpms [396.413606] Starting dynamic subtest: pipe-A-HDMI-A-1 [397.056122] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.643s) [397.066862] Starting dynamic subtest: pipe-D-HDMI-A-1 [397.650077] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.591s) [397.650764] Subtest cursor-dpms: SUCCESS (1.239s) [397.828012] [082/134] (609s left) kms_chamelium_frames (hdmi-frame-dump) [397.974289] Subtest hdmi-frame-dump: SKIP (0.000s) [398.064361] [083/134] (609s left) gen3_render_linear_blits [398.143278] [084/134] (609s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [398.240390] Starting subtest: yf-tiled-64bpp-rotate-180 [398.241763] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [398.369143] [085/134] (609s left) kms_properties (invalid-properties-legacy) [398.457114] Starting subtest: invalid-properties-legacy [398.672845] Subtest invalid-properties-legacy: SUCCESS (0.210s) [398.745843] [086/134] (608s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [398.784722] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [398.894872] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s) [398.977120] [087/134] (608s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [399.067778] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [399.069128] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [399.186389] [088/134] (608s left) kms_psr (psr-no-drrs) [399.272573] Subtest psr-no-drrs: SKIP (0.000s) [399.316702] [089/134] (608s left) gem_exec_params (readonly) [399.353333] Starting subtest: readonly [399.355101] Subtest readonly: SUCCESS (0.001s) [399.476714] [090/134] (608s left) i915_hangman (gt-error-state-capture) [399.518964] Starting subtest: gt-error-state-capture [399.519663] Starting dynamic subtest: rcs0 [408.929183] Dynamic subtest rcs0: SUCCESS (9.410s) [408.937505] Starting dynamic subtest: bcs0 [418.923212] Dynamic subtest bcs0: SUCCESS (9.992s) [418.941833] Starting dynamic subtest: vcs0 [428.897130] Dynamic subtest vcs0: SUCCESS (9.971s) [428.915792] Starting dynamic subtest: vcs1 [438.875844] Dynamic subtest vcs1: SUCCESS (9.975s) [438.893964] Starting dynamic subtest: vecs0 [448.931058] Dynamic subtest vecs0: SUCCESS (10.052s) [448.932387] Subtest gt-error-state-capture: SUCCESS (49.414s) [449.024222] [091/134] (558s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [449.112649] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [449.113381] Starting dynamic subtest: pipe-A-valid-mode [451.004673] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.892s) [451.005410] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SUCCESS (1.893s) [451.153615] [092/134] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [451.248772] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [451.250118] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [451.373088] [093/134] (556s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [451.464747] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [451.504950] [094/134] (556s left) gem_ctx_param (invalid-get-no-zeromap) [451.537637] Starting subtest: invalid-get-no-zeromap [451.538337] Subtest invalid-get-no-zeromap: SUCCESS (0.000s) [451.631937] [095/134] (556s left) kms_flip (bo-too-big) [451.718576] Starting subtest: bo-too-big [451.721102] Starting dynamic subtest: A-HDMI-A1 [452.046337] Dynamic subtest A-HDMI-A1: SUCCESS (0.325s) [452.058213] Starting dynamic subtest: B-HDMI-A1 [452.362721] Dynamic subtest B-HDMI-A1: SUCCESS (0.309s) [452.373596] Starting dynamic subtest: C-HDMI-A1 [452.687062] Dynamic subtest C-HDMI-A1: SUCCESS (0.323s) [452.698286] Starting dynamic subtest: D-HDMI-A1 [453.000986] Dynamic subtest D-HDMI-A1: SUCCESS (0.311s) [453.001749] Subtest bo-too-big: SUCCESS (1.282s) [453.195224] [096/134] (554s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render) [453.288716] Starting subtest: fbcpsr-abgr161616f-draw-render [453.290078] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s) [453.407796] [097/134] (554s left) kms_flip (2x-flip-vs-dpms) [453.493090] Starting subtest: 2x-flip-vs-dpms [453.502257] Subtest 2x-flip-vs-dpms: SKIP (0.009s) [453.580073] [098/134] (554s left) core_auth (getclient-master-drop) [453.611006] Starting subtest: getclient-master-drop [453.613952] Subtest getclient-master-drop: SUCCESS (0.002s) [453.704264] [099/134] (554s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [453.795679] Starting subtest: fbc-1p-primscrn-cur-indfb-move [455.332775] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (1.537s) [455.488951] [100/134] (552s left) gem_render_copy (yf-tiled) [455.530119] Starting subtest: yf-tiled [455.530815] Starting dynamic subtest: smem [455.598822] Dynamic subtest smem: SUCCESS (0.068s) [455.599532] Subtest yf-tiled: SUCCESS (0.069s) [455.789612] [101/134] (552s left) i915_selftest (mock) [456.816234] Starting subtest: mock [456.818697] Starting dynamic subtest: sanitycheck [457.665651] Dynamic subtest sanitycheck: SUCCESS (0.852s) [457.675681] Starting dynamic subtest: shmem [458.388591] Dynamic subtest shmem: SUCCESS (0.721s) [458.398703] Starting dynamic subtest: fence [466.044664] Dynamic subtest fence: SUCCESS (7.654s) [466.054190] Starting dynamic subtest: scatterlist [467.762305] Dynamic subtest scatterlist: SUCCESS (1.716s) [467.768408] Starting dynamic subtest: syncmap [470.719653] Dynamic subtest syncmap: SUCCESS (2.955s) [470.728499] Starting dynamic subtest: uncore [471.433471] Dynamic subtest uncore: SUCCESS (0.712s) [471.443682] Starting dynamic subtest: ring [472.135515] Dynamic subtest ring: SUCCESS (0.700s) [472.145807] Starting dynamic subtest: engine [472.855419] Dynamic subtest engine: SUCCESS (0.718s) [472.865750] Starting dynamic subtest: timelines [477.297566] Dynamic subtest timelines: SUCCESS (4.440s) [477.307241] Starting dynamic subtest: requests [479.997646] Dynamic subtest requests: SUCCESS (2.698s) [480.006209] Starting dynamic subtest: objects [480.823585] Dynamic subtest objects: SUCCESS (0.824s) [480.832980] Starting dynamic subtest: phys [481.627467] Dynamic subtest phys: SUCCESS (0.802s) [481.637177] Starting dynamic subtest: dmabuf [482.482569] Dynamic subtest dmabuf: SUCCESS (0.853s) [482.492774] Starting dynamic subtest: vma [489.904547] Dynamic subtest vma: SUCCESS (7.420s) [489.914592] Starting dynamic subtest: evict [491.561418] Dynamic subtest evict: SUCCESS (1.655s) [491.571177] Starting dynamic subtest: gtt [495.334583] Dynamic subtest gtt: SUCCESS (3.771s) [495.343750] Starting dynamic subtest: hugepages [496.344478] Dynamic subtest hugepages: SUCCESS (1.008s) [496.354246] Starting dynamic subtest: memory_region [499.600443] Dynamic subtest memory_region: SUCCESS (3.254s) [499.601423] Subtest mock: SUCCESS (42.789s) [499.634062] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [499.634843] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [499.638145] [102/134] (508s left) kms_big_fb (x-tiled-8bpp-rotate-180) [500.716826] Starting subtest: x-tiled-8bpp-rotate-180 [501.731433] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.016s) [501.860144] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [501.861535] [FACT kms_big_fb (x-tiled-8bpp-rotate-180)] new: kernel.kmod_is_loaded.i915: true [501.864403] [103/134] (506s left) gem_userptr_blits (relocations) [501.909410] Starting subtest: relocations [501.910148] Subtest relocations: SUCCESS (0.002s) [502.047294] [104/134] (506s left) gem_exec_fence (submit3) [502.207924] Starting subtest: submit3 [502.209053] Starting dynamic subtest: rcs0 [502.216197] Dynamic subtest rcs0: SUCCESS (0.007s) [502.226027] Starting dynamic subtest: bcs0 [502.226755] Dynamic subtest bcs0: SUCCESS (0.004s) [502.234461] Starting dynamic subtest: vcs0 [502.235163] Dynamic subtest vcs0: SUCCESS (0.004s) [502.242324] Starting dynamic subtest: vcs1 [502.243013] Dynamic subtest vcs1: SUCCESS (0.004s) [502.249824] Starting dynamic subtest: vecs0 [502.250490] Dynamic subtest vecs0: SUCCESS (0.004s) [502.251152] Subtest submit3: SUCCESS (0.029s) [502.702605] [105/134] (505s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [502.735070] Subtest flip-primary-invalidate-overlay: SKIP (0.000s) [502.799998] [106/134] (505s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [502.833236] Starting subtest: multi-wait-all-for-submit-available-submitted [502.833923] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [502.919936] [107/134] (505s left) gem_ctx_engines (invalid-engines) [502.960493] Starting subtest: invalid-engines [502.965916] Subtest invalid-engines: SUCCESS (0.005s) [503.149643] [108/134] (505s left) gem_exec_schedule (pi-ringfull) [503.316916] Starting subtest: pi-ringfull [503.317834] Starting dynamic subtest: rcs0 [503.345213] Dynamic subtest rcs0: SUCCESS (0.029s) [503.353637] Starting dynamic subtest: bcs0 [503.370149] Dynamic subtest bcs0: SUCCESS (0.024s) [503.378897] Starting dynamic subtest: vcs0 [503.395567] Dynamic subtest vcs0: SUCCESS (0.024s) [503.406328] Starting dynamic subtest: vcs1 [503.420283] Dynamic subtest vcs1: SUCCESS (0.024s) [503.428904] Starting dynamic subtest: vecs0 [503.445237] Dynamic subtest vecs0: SUCCESS (0.024s) [503.445943] Subtest pi-ringfull: SUCCESS (0.131s) [503.631021] [109/134] (504s left) gem_exec_whisper (basic-fds-all) [503.672790] Starting subtest: basic-fds-all [506.197404] Subtest basic-fds-all: SUCCESS (2.524s) [506.400136] [110/134] (502s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [506.484968] Starting subtest: plane-upscale-factor-0-25-with-modifiers [506.485843] Starting dynamic subtest: pipe-A [506.856725] Dynamic subtest pipe-A: SUCCESS (0.372s) [506.867272] Starting dynamic subtest: pipe-B [507.292719] Dynamic subtest pipe-B: SUCCESS (0.435s) [507.303895] Starting dynamic subtest: pipe-C [507.729837] Dynamic subtest pipe-C: SUCCESS (0.436s) [507.740465] Starting dynamic subtest: pipe-D [508.163154] Dynamic subtest pipe-D: SUCCESS (0.432s) [508.163886] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (1.679s) [508.357227] [111/134] (500s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [508.448589] Starting subtest: 2x-flip-vs-blocking-wf-vblank [508.457643] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.009s) [508.552644] [112/134] (500s left) kms_plane_multiple (tiling-x) [508.636888] Starting subtest: tiling-x [508.638682] Starting dynamic subtest: pipe-A-HDMI-A-1 [509.206209] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.568s) [509.216071] Starting dynamic subtest: pipe-B-HDMI-A-1 [509.813321] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.605s) [509.821840] Starting dynamic subtest: pipe-C-HDMI-A-1 [510.379723] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.564s) [510.389276] Starting dynamic subtest: pipe-D-HDMI-A-1 [510.931482] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.550s) [510.932183] Subtest tiling-x: SUCCESS (2.296s) [511.098407] [113/134] (497s left) gem_flink_basic (basic) [511.134345] Starting subtest: basic [511.135042] Subtest basic: SUCCESS (0.000s) [511.254088] [114/134] (497s left) gem_exec_parallel (basic) [511.293346] Starting subtest: basic [511.294039] Starting dynamic subtest: rcs0 [512.910075] Dynamic subtest rcs0: SUCCESS (1.616s) [512.922977] Starting dynamic subtest: bcs0 [514.492251] Dynamic subtest bcs0: SUCCESS (1.581s) [514.503040] Starting dynamic subtest: vcs0 [516.067019] Dynamic subtest vcs0: SUCCESS (1.573s) [516.075751] Starting dynamic subtest: vcs1 [517.620327] Dynamic subtest vcs1: SUCCESS (1.552s) [517.629010] Starting dynamic subtest: vecs0 [519.186440] Dynamic subtest vecs0: SUCCESS (1.565s) [519.187350] Subtest basic: SUCCESS (7.894s) [519.367898] [115/134] (489s left) gem_exec_whisper (basic-queues-priority-all) [519.409826] Starting subtest: basic-queues-priority-all [522.305014] Subtest basic-queues-priority-all: SUCCESS (2.895s) [522.497371] [116/134] (486s left) kms_psr (fbc-psr-sprite-plane-move) [522.584018] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [522.634222] [117/134] (486s left) gem_sync (basic-many-each) [522.679109] Starting subtest: basic-many-each [524.908768] Subtest basic-many-each: SUCCESS (2.230s) [525.129508] [118/134] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [525.218716] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [525.220069] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [525.330645] [119/134] (483s left) gem_fence_thrash (bo-write-verify-threaded-x) [525.362482] Starting subtest: bo-write-verify-threaded-x [529.920957] Subtest bo-write-verify-threaded-x: SUCCESS (4.526s) [530.027360] [120/134] (479s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [530.060072] Starting subtest: multi-wait-available-unsubmitted-signaled [530.060754] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [530.145767] [121/134] (478s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [530.231898] Starting subtest: primary-yf-tiled-reflect-x-270 [530.282290] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.050s) [530.382030] [122/134] (478s left) kms_psr (fbc-pr-sprite-mmap-gtt) [530.465541] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [530.505272] [123/134] (478s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [530.593666] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [530.594981] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [530.707091] [124/134] (478s left) syncobj_wait (multi-wait-for-submit-submitted) [530.740746] Starting subtest: multi-wait-for-submit-submitted [530.856143] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s) [530.930953] [125/134] (478s left) sw_sync (sync_busy_fork_unixsocket) [530.961868] Starting subtest: sync_busy_fork_unixsocket [530.970897] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [531.055335] [126/134] (478s left) kms_async_flips (crc) [531.139830] Starting subtest: crc [531.259806] Starting dynamic subtest: pipe-A-HDMI-A-1 [533.408139] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.140s) [533.539082] Starting dynamic subtest: pipe-B-HDMI-A-1 [535.653079] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.114s) [535.787270] Starting dynamic subtest: pipe-C-HDMI-A-1 [537.922114] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.133s) [538.043543] Starting dynamic subtest: pipe-D-HDMI-A-1 [540.161465] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.118s) [540.162203] Subtest crc: SUCCESS (9.014s) [540.400814] [127/134] (468s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [540.492839] Starting subtest: cursorB-vs-flipA-atomic [540.495823] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s) [540.579855] [128/134] (468s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [540.667716] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [540.669060] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [540.775886] [129/134] (468s left) gem_exec_flush (basic-wb-rw-before-default) [540.817738] Starting subtest: basic-wb-rw-before-default [546.241629] Subtest basic-wb-rw-before-default: SUCCESS (5.425s) [546.462887] [130/134] (463s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [546.549308] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [546.551428] Starting dynamic subtest: pipe-A-HDMI-A-1 [546.558264] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [546.567960] Starting dynamic subtest: pipe-B-HDMI-A-1 [546.574809] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [546.584270] Starting dynamic subtest: pipe-C-HDMI-A-1 [546.591026] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [546.600182] Starting dynamic subtest: pipe-D-HDMI-A-1 [546.607296] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [546.608699] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.009s) [546.800921] [131/134] (462s left) kms_properties (colorop-properties-legacy) [546.888931] Starting subtest: colorop-properties-legacy [546.889664] Starting dynamic subtest: pipe-A-HDMI-A-1 [546.974229] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.085s) [546.984021] Starting dynamic subtest: pipe-B-HDMI-A-1 [547.092710] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.115s) [547.102585] Starting dynamic subtest: pipe-C-HDMI-A-1 [547.219903] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.123s) [547.228178] Starting dynamic subtest: pipe-D-HDMI-A-1 [547.341971] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.121s) [547.342732] Subtest colorop-properties-legacy: SUCCESS (0.454s) [547.503601] [132/134] (462s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [547.592713] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [547.594055] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [547.686638] [133/134] (461s left) kms_busy (extended-modeset-hang-newfb) [547.776048] Starting subtest: extended-modeset-hang-newfb [547.776782] Starting dynamic subtest: pipe-A [572.096523] Dynamic subtest pipe-A: SUCCESS (24.320s) [572.108055] Starting dynamic subtest: pipe-D [596.150131] Dynamic subtest pipe-D: SUCCESS (24.048s) [596.150914] Subtest extended-modeset-hang-newfb: SUCCESS (48.375s) [596.284697] [134/134] (413s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [596.379831] Starting subtest: plane-lut1d-ctm3x4-lut1d [596.395665] Starting dynamic subtest: pipe-A-HDMI-A-1 [596.562393] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.166s) [596.729882] Starting dynamic subtest: pipe-B-HDMI-A-1 [596.868473] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.148s) [597.013524] Starting dynamic subtest: pipe-C-HDMI-A-1 [597.154622] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s) [597.298402] Starting dynamic subtest: pipe-D-HDMI-A-1 [597.439134] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.147s) [597.504313] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (1.125s) [597.631405] Closing watchdogs results: parsing output: 0/ for test: api_intel_allocator results: parsing output: 1/ for test: gen9_exec_parse results: parsing output: 2/ for test: i915_pm_rc6_residency results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: kms_plane_scaling results: parsing output: 6/ for test: kms_plane_cursor results: parsing output: 7/ for test: sw_sync results: parsing output: 8/ for test: gen9_exec_parse results: parsing output: 9/ for test: gem_mmap_offset results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_vblank results: parsing output: 12/ for test: gem_softpin results: parsing output: 13/ for test: kms_chamelium_color results: parsing output: 14/ for test: syncobj_timeline results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: prime_mmap results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_render_copy results: parsing output: 20/ for test: kms_cursor_legacy results: parsing output: 21/ for test: gem_ctx_create results: parsing output: 22/ for test: kms_cursor_legacy results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_basic results: parsing output: 25/ for test: syncobj_timeline results: parsing output: 26/ for test: kms_pm_dc results: parsing output: 27/ for test: gem_exec_reloc results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_content_protection results: parsing output: 31/ for test: kms_cursor_crc results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: gem_ctx_shared results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: prime_busy results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: sysfs_preempt_timeout results: parsing output: 39/ for test: gem_pwrite results: parsing output: 40/ for test: kms_vblank results: parsing output: 41/ for test: kms_chamelium_hpd results: parsing output: 42/ for test: prime_self_import results: parsing output: 43/ for test: kms_flip_scaled_crc results: parsing output: 44/ for test: gem_exec_reloc results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_multipipe_modeset results: parsing output: 47/ for test: kms_psr2_sf results: parsing output: 48/ for test: drm_read results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: prime_mmap results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: gem_exec_suspend results: parsing output: 55/ for test: perf_pmu results: parsing output: 56/ for test: gem_wait results: parsing output: 57/ for test: prime_mmap results: parsing output: 58/ for test: gem_exec_balancer results: parsing output: 59/ for test: kms_dp_link_training results: parsing output: 60/ for test: gem_busy results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_cursor_crc results: parsing output: 63/ for test: kms_joiner results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: perf_pmu results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: kms_ccs results: parsing output: 68/ for test: gem_exec_schedule results: parsing output: 69/ for test: gem_workarounds results: parsing output: 70/ for test: kms_hdr results: parsing output: 71/ for test: kms_prime results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_endless results: parsing output: 74/ for test: kms_async_flips results: parsing output: 75/ for test: dmabuf_sync_file results: parsing output: 76/ for test: kms_plane results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: kms_chamelium_frames results: parsing output: 82/ for test: gen3_render_linear_blits results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: kms_properties results: parsing output: 85/ for test: syncobj_wait results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: gem_exec_params results: parsing output: 89/ for test: i915_hangman results: parsing output: 90/ for test: kms_flip_scaled_crc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr2_sf results: parsing output: 93/ for test: gem_ctx_param results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: core_auth results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: i915_selftest results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: gem_exec_fence results: parsing output: 104/ for test: kms_psr_stress_test results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: gem_ctx_engines results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: gem_exec_whisper results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_flip results: parsing output: 111/ for test: kms_plane_multiple results: parsing output: 112/ for test: gem_flink_basic results: parsing output: 113/ for test: gem_exec_parallel results: parsing output: 114/ for test: gem_exec_whisper results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: gem_sync results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_fence_thrash results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: kms_rotation_crc results: parsing output: 121/ for test: kms_psr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: sw_sync results: parsing output: 125/ for test: kms_async_flips results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_flush results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: kms_properties results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_busy results: parsing output: 133/ for test: kms_color_pipeline Done.