[56.627152] Initializing watchdogs [56.627284] /dev/watchdog0 [56.643850] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.649205] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.654335] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.657956] [001/156] (960s left) kms_sequence (queue-busy) [56.777709] Starting subtest: queue-busy [56.779937] Starting dynamic subtest: pipe-A-eDP-1 [58.752242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.953s) [58.761178] Starting dynamic subtest: pipe-B-eDP-1 [61.390223] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.617s) [61.399836] Starting dynamic subtest: pipe-C-eDP-1 [64.025205] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s) [64.035060] Starting dynamic subtest: pipe-D-eDP-1 [66.657850] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s) [66.660147] Subtest queue-busy: SUCCESS (9.815s) [67.558238] [002/156] (949s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [67.683744] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [78.897915] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.197s) [79.707306] [003/156] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [79.813528] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [79.818085] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [79.916735] [004/156] (937s left) gem_mmap_wc (fault-concurrent) [79.983645] Subtest fault-concurrent: SKIP (0.000s) [80.049147] [005/156] (937s left) kms_big_fb (4-tiled-64bpp-rotate-270) [80.145265] Starting subtest: 4-tiled-64bpp-rotate-270 [80.164445] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s) [80.263743] [006/156] (937s left) kms_content_protection (uevent) [80.403967] Starting subtest: uevent [80.408552] Subtest uevent: SKIP (0.000s) [80.517825] [007/156] (936s left) prime_self_import (basic-llseek-bad) [80.552511] Starting subtest: basic-llseek-bad [80.575312] Subtest basic-llseek-bad: SUCCESS (0.021s) [80.697219] [008/156] (936s left) core_setmaster (master-drop-set-user) [80.779484] Starting subtest: master-drop-set-user [80.793448] Subtest master-drop-set-user: SUCCESS (0.014s) [80.828628] [009/156] (936s left) gem_exec_create (madvise) [80.883656] Starting subtest: madvise [80.885724] Starting dynamic subtest: smem [102.337343] Dynamic subtest smem: SUCCESS (21.449s) [102.340217] Subtest madvise: SUCCESS (21.449s) [103.172224] [010/156] (914s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [103.269266] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [103.271586] Starting dynamic subtest: pipe-A-eDP-1 [135.380780] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.965s) [135.389933] Starting dynamic subtest: pipe-B-eDP-1 [168.288114] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.665s) [168.299527] Starting dynamic subtest: pipe-C-eDP-1 [201.320742] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.697s) [201.330102] Starting dynamic subtest: pipe-D-eDP-1 [234.281523] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.608s) [234.284263] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.938s) [235.478676] [011/156] (782s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-render) [235.590916] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-render [235.596182] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [235.698386] [012/156] (781s left) syncobj_wait (wait-any-interrupted) [235.751737] Starting subtest: wait-any-interrupted [235.858191] Subtest wait-any-interrupted: SUCCESS (0.105s) [235.932811] [013/156] (781s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [235.988540] Starting subtest: y-tiled-to-vebox-y-tiled [235.993570] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [236.179850] [014/156] (781s left) gem_wait (invalid-flags) [236.232762] Starting subtest: invalid-flags [236.235642] Subtest invalid-flags: SUCCESS (0.000s) [236.462190] [015/156] (781s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-plflip-blt) [236.564692] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-plflip-blt [236.569917] Subtest fbcpsrhdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [236.663753] [016/156] (781s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-blt) [236.760748] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-blt [236.765795] Subtest hdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [236.844268] [017/156] (780s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [236.952368] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [236.957748] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [237.032303] [018/156] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [237.129044] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [244.712750] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.528s) [244.833571] [019/156] (773s left) gem_exec_reloc (basic-gtt-cpu) [244.884414] Subtest basic-gtt-cpu: SKIP (0.000s) [244.959126] [020/156] (772s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [245.055756] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [245.060551] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [245.137977] [021/156] (772s left) kms_chamelium_color (ctm-negative) [245.228969] Subtest ctm-negative: SKIP (0.000s) [245.276599] [022/156] (772s left) gem_mmap_gtt (hang) [245.338565] Subtest hang: SKIP (0.000s) [245.404801] [023/156] (772s left) kms_plane_scaling (planes-scaler-unity-scaling) [245.489446] Starting subtest: planes-scaler-unity-scaling [245.492152] Starting dynamic subtest: pipe-A [245.551653] Dynamic subtest pipe-A: SUCCESS (0.064s) [245.562748] Starting dynamic subtest: pipe-B [246.727260] Dynamic subtest pipe-B: SUCCESS (1.169s) [246.738330] Starting dynamic subtest: pipe-C [247.855758] Dynamic subtest pipe-C: SUCCESS (1.124s) [247.865566] Starting dynamic subtest: pipe-D [248.990320] Dynamic subtest pipe-D: SUCCESS (1.130s) [248.992790] Subtest planes-scaler-unity-scaling: SUCCESS (3.491s) [250.139440] [024/156] (767s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [250.236600] Starting subtest: pr-cursor-plane-move-continuous-sf [250.241524] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [250.301791] [025/156] (767s left) gem_exec_balancer (noheartbeat) [250.568159] Starting subtest: noheartbeat [250.573643] Subtest noheartbeat: SKIP (0.000s) [250.657572] [026/156] (767s left) kms_flip (blocking-absolute-wf_vblank) [250.756265] Starting subtest: blocking-absolute-wf_vblank [250.758818] Starting dynamic subtest: A-eDP1 [259.547393] Dynamic subtest A-eDP1: SUCCESS (8.744s) [259.557601] Starting dynamic subtest: B-eDP1 [268.279404] Dynamic subtest B-eDP1: SUCCESS (8.723s) [268.293762] Starting dynamic subtest: C-eDP1 [277.026624] Dynamic subtest C-eDP1: SUCCESS (8.724s) [277.042532] Starting dynamic subtest: D-eDP1 [285.765379] Dynamic subtest D-eDP1: SUCCESS (8.732s) [285.767874] Subtest blocking-absolute-wf_vblank: SUCCESS (34.940s) [286.927910] [027/156] (731s left) kms_getfb (getfb2-accept-nv12) [287.042754] Starting subtest: getfb2-accept-nv12 [287.045696] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [287.150105] [028/156] (731s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [287.197308] Starting subtest: multi-wait-for-submit-submitted-signaled [287.200184] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [287.301011] [029/156] (730s left) gem_exec_balancer (bonded-chain) [287.356097] Starting subtest: bonded-chain [294.375973] Subtest bonded-chain: SUCCESS (7.015s) [295.182242] [030/156] (723s left) gem_exec_reloc (basic-concurrent16) [295.245375] Subtest basic-concurrent16: SKIP (0.000s) [295.318970] [031/156] (723s left) perf (gen12-group-exclusive-stream-sample-oa) [295.446758] Starting subtest: gen12-group-exclusive-stream-sample-oa [295.468582] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.021s) [295.515373] [032/156] (722s left) kms_legacy_colorkey (basic) [295.608507] Starting subtest: basic [295.611291] Starting dynamic subtest: pipe-A [295.651585] Dynamic subtest pipe-A: SUCCESS (0.045s) [295.665593] Starting dynamic subtest: pipe-B [295.668069] Dynamic subtest pipe-B: SUCCESS (0.001s) [295.677756] Starting dynamic subtest: pipe-C [295.680552] Dynamic subtest pipe-C: SUCCESS (0.000s) [295.690044] Starting dynamic subtest: pipe-D [295.692595] Dynamic subtest pipe-D: SUCCESS (0.000s) [295.695522] Subtest basic: SUCCESS (0.052s) [295.733692] [033/156] (722s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [295.788569] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [295.791578] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [295.886657] [034/156] (722s left) gem_tiled_blits (basic) [295.946593] Subtest basic: SKIP (0.000s) [296.019141] [035/156] (722s left) kms_setmode (clone-exclusive-crtc) [296.071847] Starting subtest: clone-exclusive-crtc [296.080288] Subtest clone-exclusive-crtc: SKIP (0.000s) [296.162099] [036/156] (722s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-pwrite) [296.250641] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-pwrite [296.255597] Subtest fbchdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [296.352735] [037/156] (722s left) kms_frontbuffer_tracking (psr-slowdraw) [296.446035] Starting subtest: psr-slowdraw [321.634337] Subtest psr-slowdraw: SUCCESS (25.178s) [321.769887] [038/156] (696s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [321.864590] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [321.870459] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [321.934059] [039/156] (696s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt) [322.037510] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt [322.042738] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [322.126927] [040/156] (696s left) kms_flip (2x-flip-vs-rmfb) [322.220767] Starting subtest: 2x-flip-vs-rmfb [322.231772] Subtest 2x-flip-vs-rmfb: SKIP (0.010s) [322.338208] [041/156] (696s left) gem_exec_whisper (basic-contexts-forked-all) [322.397536] Starting subtest: basic-contexts-forked-all [345.065584] Subtest basic-contexts-forked-all: SUCCESS (22.676s) [345.253649] [042/156] (673s left) kms_addfb_basic (unused-pitches) [345.319715] Starting subtest: unused-pitches [345.322474] Subtest unused-pitches: SUCCESS (0.000s) [345.451537] [043/156] (673s left) i915_drm_fdinfo (virtual-idle) [345.491196] Starting subtest: virtual-idle [348.545753] Subtest virtual-idle: SUCCESS (3.056s) [348.628392] [044/156] (670s left) kms_invalid_mode (uint-max-clock) [348.721887] Starting subtest: uint-max-clock [348.724597] Starting dynamic subtest: pipe-A-eDP-1 [349.003104] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [349.015430] Starting dynamic subtest: pipe-B-eDP-1 [349.017694] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [349.027841] Starting dynamic subtest: pipe-C-eDP-1 [349.030526] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [349.040477] Starting dynamic subtest: pipe-D-eDP-1 [349.043383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [349.046100] Subtest uint-max-clock: SUCCESS (0.289s) [349.889642] [045/156] (669s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [349.976631] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [349.981357] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [350.048344] [046/156] (668s left) i915_suspend (sysfs-reader) [350.112645] Starting subtest: sysfs-reader [368.085419] Subtest sysfs-reader: SUCCESS (3.066s) [368.160784] [047/156] (650s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping) [368.260246] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping [368.263840] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [368.328648] [048/156] (650s left) kms_cursor_legacy (torture-bo) [368.450113] Starting subtest: torture-bo [368.451886] Starting dynamic subtest: pipe-A [374.285162] Dynamic subtest pipe-A: SUCCESS (5.711s) [374.297926] Starting dynamic subtest: pipe-B [380.460937] Dynamic subtest pipe-B: SUCCESS (6.190s) [380.478488] Starting dynamic subtest: pipe-C [387.504704] Dynamic subtest pipe-C: SUCCESS (7.023s) [387.516736] Starting dynamic subtest: pipe-D [393.438857] Dynamic subtest pipe-D: SUCCESS (5.922s) [393.451270] Starting dynamic subtest: all-pipes [399.119881] Dynamic subtest all-pipes: SUCCESS (5.677s) [399.122141] Subtest torture-bo: SUCCESS (30.534s) [399.302318] [049/156] (619s left) gem_mmap_wc (set-cache-level) [399.359985] Subtest set-cache-level: SKIP (0.000s) [399.413189] [050/156] (619s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [399.500481] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [399.502911] Starting dynamic subtest: pipe-A-eDP-1 [400.409379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.903s) [400.420294] Starting dynamic subtest: pipe-B-eDP-1 [401.946593] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s) [401.957367] Starting dynamic subtest: pipe-C-eDP-1 [403.480185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.534s) [403.491300] Starting dynamic subtest: pipe-D-eDP-1 [405.016338] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.535s) [405.018704] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.510s) [406.178701] [051/156] (612s left) kms_psr (psr-sprite-plane-move) [406.284271] Starting subtest: psr-sprite-plane-move [406.286521] Starting dynamic subtest: eDP-1 [408.026338] Dynamic subtest eDP-1: SUCCESS (1.742s) [408.028504] Subtest psr-sprite-plane-move: SUCCESS (1.743s) [408.864768] [052/156] (610s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [408.912641] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [409.015774] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [409.090837] [053/156] (610s left) sriov_basic (enable-vfs-autoprobe-on) [409.144373] Starting subtest: enable-vfs-autoprobe-on [409.146863] Starting dynamic subtest: numvfs-1 [409.151913] Dynamic subtest numvfs-1: SKIP (0.001s) [409.163243] Starting dynamic subtest: numvfs-2 [409.167868] Dynamic subtest numvfs-2: SKIP (0.001s) [409.177685] Starting dynamic subtest: numvfs-3 [409.182075] Dynamic subtest numvfs-3: SKIP (0.000s) [409.191777] Starting dynamic subtest: numvfs-4 [409.196282] Dynamic subtest numvfs-4: SKIP (0.001s) [409.206613] Starting dynamic subtest: numvfs-5 [409.211011] Dynamic subtest numvfs-5: SKIP (0.001s) [409.220567] Starting dynamic subtest: numvfs-6 [409.225002] Dynamic subtest numvfs-6: SKIP (0.001s) [409.234601] Starting dynamic subtest: numvfs-7 [409.238992] Dynamic subtest numvfs-7: SKIP (0.001s) [409.248547] Starting dynamic subtest: numvfs-random [409.252847] Dynamic subtest numvfs-random: SKIP (0.000s) [409.262544] Starting dynamic subtest: numvfs-all [409.267032] Dynamic subtest numvfs-all: SKIP (0.000s) [409.271400] Subtest enable-vfs-autoprobe-on: SKIP (0.011s) [409.309563] [054/156] (609s left) kms_draw_crc (draw-method-mmap-wc) [409.410658] Starting subtest: draw-method-mmap-wc [409.412758] Starting dynamic subtest: xrgb8888-untiled [409.675599] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [409.687207] Starting dynamic subtest: rgb565-untiled [409.875255] Dynamic subtest rgb565-untiled: SUCCESS (0.199s) [409.886233] Starting dynamic subtest: xrgb2101010-untiled [410.097384] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [410.107193] Starting dynamic subtest: xbgr16161616f-untiled [410.297912] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.200s) [410.307660] Starting dynamic subtest: xrgb8888-xtiled [410.430518] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [410.439983] Starting dynamic subtest: rgb565-xtiled [410.563776] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [410.573721] Starting dynamic subtest: xrgb2101010-xtiled [410.677509] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [410.688033] Starting dynamic subtest: xbgr16161616f-xtiled [410.808317] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s) [410.818011] Starting dynamic subtest: xrgb8888-4tiled [410.952939] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [410.963578] Starting dynamic subtest: rgb565-4tiled [411.108510] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s) [411.118243] Starting dynamic subtest: xrgb2101010-4tiled [411.241975] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s) [411.251916] Starting dynamic subtest: xbgr16161616f-4tiled [411.420032] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s) [411.421950] Subtest draw-method-mmap-wc: SUCCESS (2.012s) [411.530162] [055/156] (607s left) syncobj_timeline (single-wait-available-submitted) [411.582688] Starting subtest: single-wait-available-submitted [411.584569] Subtest single-wait-available-submitted: SUCCESS (0.000s) [411.696295] [056/156] (607s left) gem_exec_schedule (submit-golden-slice) [411.759355] Starting subtest: submit-golden-slice [411.761334] Starting dynamic subtest: rcs0 [411.791048] Dynamic subtest rcs0: SUCCESS (0.034s) [411.801649] Starting dynamic subtest: bcs0 [411.822250] Dynamic subtest bcs0: SUCCESS (0.032s) [411.832732] Starting dynamic subtest: vcs0 [411.861282] Dynamic subtest vcs0: SUCCESS (0.038s) [411.872578] Starting dynamic subtest: vcs1 [411.896686] Dynamic subtest vcs1: SUCCESS (0.034s) [411.911740] Starting dynamic subtest: vecs0 [411.934072] Dynamic subtest vecs0: SUCCESS (0.036s) [411.944705] Starting dynamic subtest: ccs0 [411.973454] Dynamic subtest ccs0: SUCCESS (0.037s) [411.975534] Subtest submit-golden-slice: SUCCESS (0.219s) [413.161315] [057/156] (606s left) prime_mmap (test_correct_cpu_write) [413.223254] Starting subtest: test_correct_cpu_write [413.225645] Starting dynamic subtest: test_correct_cpu_write-smem [413.227671] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [413.229760] Subtest test_correct_cpu_write: SUCCESS (0.001s) [413.343495] [058/156] (606s left) kms_flip (plain-flip-interruptible) [413.438281] Starting subtest: plain-flip-interruptible [413.440788] Starting dynamic subtest: A-eDP1 [415.080854] Dynamic subtest A-eDP1: SUCCESS (1.642s) [415.094205] Starting dynamic subtest: B-eDP1 [416.712020] Dynamic subtest B-eDP1: SUCCESS (1.630s) [416.724823] Starting dynamic subtest: C-eDP1 [418.340211] Dynamic subtest C-eDP1: SUCCESS (1.625s) [418.352312] Starting dynamic subtest: D-eDP1 [419.960329] Dynamic subtest D-eDP1: SUCCESS (1.619s) [419.965818] Subtest plain-flip-interruptible: SUCCESS (6.527s) [421.129954] [059/156] (598s left) kms_color_pipeline (plane-lut1d-ctm3x4) [421.231872] Starting subtest: plane-lut1d-ctm3x4 [421.355725] Starting dynamic subtest: pipe-A-plane-0 [421.501364] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [421.511770] Starting dynamic subtest: pipe-A-plane-1 [421.644094] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s) [421.654367] Starting dynamic subtest: pipe-A-plane-2 [421.789412] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s) [423.038722] Starting dynamic subtest: pipe-B-plane-0 [423.227562] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s) [423.237991] Starting dynamic subtest: pipe-B-plane-1 [423.405947] Dynamic subtest pipe-B-plane-1: SUCCESS (0.177s) [423.416339] Starting dynamic subtest: pipe-B-plane-2 [423.594425] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s) [424.863744] Starting dynamic subtest: pipe-C-plane-0 [424.999735] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s) [425.011182] Starting dynamic subtest: pipe-C-plane-1 [425.166223] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [425.178408] Starting dynamic subtest: pipe-C-plane-2 [425.322376] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [426.473949] Starting dynamic subtest: pipe-D-plane-0 [426.611081] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [426.622331] Starting dynamic subtest: pipe-D-plane-1 [426.777658] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s) [426.789454] Starting dynamic subtest: pipe-D-plane-2 [426.908708] Dynamic subtest pipe-D-plane-2: SUCCESS (0.132s) [427.200805] Subtest plane-lut1d-ctm3x4: SUCCESS (5.969s) [428.066143] [060/156] (591s left) kms_cursor_crc (cursor-offscreen-max-size) [428.365534] Starting subtest: cursor-offscreen-max-size [428.372283] Subtest cursor-offscreen-max-size: SKIP (0.000s) [428.509899] [061/156] (591s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [428.894022] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [429.683459] [062/156] (589s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [429.790165] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [429.794430] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [429.901337] [063/156] (589s left) gem_close_race (multigpu-basic-threads) [429.957269] Starting subtest: multigpu-basic-threads [429.961713] Subtest multigpu-basic-threads: SKIP (0.000s) [430.176071] [064/156] (589s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw) [430.269935] Starting subtest: fbchdr-2p-pri-indfb-multidraw [430.274241] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s) [430.377056] [065/156] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [430.470291] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [430.474487] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [430.565225] [066/156] (589s left) gem_exec_schedule (preempt-other) [430.638659] Starting subtest: preempt-other [430.640975] Starting dynamic subtest: rcs0 [430.701485] Dynamic subtest rcs0: SUCCESS (0.069s) [430.715349] Starting dynamic subtest: bcs0 [430.772521] Dynamic subtest bcs0: SUCCESS (0.071s) [430.784244] Starting dynamic subtest: vcs0 [430.842559] Dynamic subtest vcs0: SUCCESS (0.068s) [430.855771] Starting dynamic subtest: vcs1 [430.912924] Dynamic subtest vcs1: SUCCESS (0.069s) [430.928277] Starting dynamic subtest: vecs0 [430.980343] Dynamic subtest vecs0: SUCCESS (0.066s) [430.992589] Starting dynamic subtest: ccs0 [431.046263] Dynamic subtest ccs0: SUCCESS (0.066s) [431.048690] Subtest preempt-other: SUCCESS (0.416s) [432.157720] [067/156] (587s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [432.253472] Starting subtest: fbc-farfromfence-mmap-gtt [432.257869] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [432.359409] [068/156] (587s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [432.415204] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [432.417517] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [432.515399] [069/156] (587s left) kms_atomic (plane-overlay-legacy) [432.619289] Starting subtest: plane-overlay-legacy [432.621678] Starting dynamic subtest: pipe-A-eDP-1 [433.027248] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.407s) [433.029459] Subtest plane-overlay-legacy: SUCCESS (0.408s) [433.826857] [070/156] (586s left) kms_cursor_crc (cursor-sliding-128x128) [434.034794] Starting subtest: cursor-sliding-128x128 [434.037082] Starting dynamic subtest: pipe-A-eDP-1 [437.272052] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.234s) [437.303667] Starting dynamic subtest: pipe-D-eDP-1 [441.224084] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.928s) [441.226512] Subtest cursor-sliding-128x128: SUCCESS (7.188s) [442.076137] [071/156] (577s left) kms_big_fb (x-tiled-16bpp-rotate-270) [442.169514] Starting subtest: x-tiled-16bpp-rotate-270 [442.188232] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s) [442.314018] [072/156] (577s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [442.416591] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [442.420646] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [442.527235] [073/156] (577s left) kms_atomic_interruptible (universal-setplane-cursor) [442.627068] Starting subtest: universal-setplane-cursor [442.629239] Starting dynamic subtest: pipe-A-eDP-1 [450.085913] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.455s) [450.088306] Subtest universal-setplane-cursor: SUCCESS (7.457s) [450.936997] [074/156] (569s left) gem_sync (basic-each) [451.019143] Starting subtest: basic-each [453.399726] Subtest basic-each: SUCCESS (2.390s) [453.583855] [075/156] (566s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [453.700159] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [453.704245] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [453.796862] [076/156] (566s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [453.896167] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [453.900161] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [454.001880] [077/156] (566s left) vgem_basic (bad-fence) [454.111888] Starting subtest: bad-fence [454.114132] Subtest bad-fence: SUCCESS (0.000s) [454.170175] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true [454.173652] [078/156] (566s left) api_intel_allocator (open-vm) [454.227305] Starting subtest: open-vm [454.232771] Subtest open-vm: SUCCESS (0.005s) [454.366599] [079/156] (565s left) gem_busy (semaphore) [454.541081] Subtest semaphore: SKIP (0.000s) [454.757666] [080/156] (565s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-msflip-blt) [454.851044] Starting subtest: psrhdr-2p-primscrn-indfb-msflip-blt [454.855673] Subtest psrhdr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [454.965206] [081/156] (565s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [455.059007] Starting subtest: fbcpsr-shrfb-scaledprimary [460.811045] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.754s) [460.914560] [082/156] (559s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [461.013741] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [468.389394] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.381s) [468.516073] [083/156] (551s left) gem_exec_params (secure-non-root) [468.565172] Starting subtest: secure-non-root [468.569370] Subtest secure-non-root: SKIP (0.000s) [468.688616] [084/156] (551s left) kms_prop_blob (invalid-get-prop-any) [468.735749] Starting subtest: invalid-get-prop-any [468.738082] Subtest invalid-get-prop-any: SUCCESS (0.000s) [468.830961] [085/156] (551s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [468.926381] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [469.904887] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.979s) [470.025153] [086/156] (550s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [470.125804] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [470.128119] Starting dynamic subtest: pipe-A-eDP-1 [470.184507] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [470.196782] Starting dynamic subtest: pipe-B-eDP-1 [470.243201] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [470.255052] Starting dynamic subtest: pipe-C-eDP-1 [470.302086] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [470.312344] Starting dynamic subtest: pipe-D-eDP-1 [470.359984] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [470.363910] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [472.458740] [087/156] (548s left) gem_pipe_control_store_loop (reused-buffer) [472.507841] Starting subtest: reused-buffer [474.716038] Subtest reused-buffer: SUCCESS (2.153s) [474.783848] [088/156] (545s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [474.889699] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [474.894138] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [474.990657] [089/156] (545s left) gem_pxp (create-regular-buffer) [475.113486] Starting subtest: create-regular-buffer [475.115866] Subtest create-regular-buffer: SUCCESS (0.000s) [475.229503] [090/156] (545s left) kms_addfb_basic (addfb25-x-tiled-legacy) [475.326851] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [475.452847] [091/156] (545s left) gem_exec_balancer (sequential) [475.503858] Starting subtest: sequential [478.594089] Subtest sequential: SUCCESS (3.090s) [478.921929] [092/156] (541s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [479.023074] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [479.027261] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [479.091696] [093/156] (541s left) perf (whitelisted-registers-userspace-config) [479.180486] Starting subtest: whitelisted-registers-userspace-config [479.182733] Subtest whitelisted-registers-userspace-config: SUCCESS (0.002s) [479.226109] [094/156] (541s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [479.317500] Starting subtest: psr-rgb565-draw-pwrite [486.485481] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.173s) [486.585138] [095/156] (534s left) syncobj_basic (create-signaled) [486.632356] Starting subtest: create-signaled [486.634210] Subtest create-signaled: SUCCESS (0.000s) [486.724776] [096/156] (534s left) prime_vgem (basic-write) [486.805794] Starting subtest: basic-write [486.829686] Subtest basic-write: SKIP (0.021s) [486.945812] [097/156] (534s left) kms_psr (psr2-primary-page-flip) [487.033804] Starting subtest: psr2-primary-page-flip [487.036089] Starting dynamic subtest: eDP-1 [488.800624] Dynamic subtest eDP-1: SUCCESS (1.766s) [488.803053] Subtest psr2-primary-page-flip: SUCCESS (1.767s) [489.665090] [098/156] (531s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-render) [489.778459] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-render [489.782730] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [489.901341] [099/156] (531s left) kms_pipe_crc_basic (read-crc) [490.004726] Starting subtest: read-crc [490.007049] Starting dynamic subtest: pipe-A-eDP-1 [490.711908] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s) [490.722235] Starting dynamic subtest: pipe-B-eDP-1 [492.131242] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [492.143351] Starting dynamic subtest: pipe-C-eDP-1 [493.540807] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s) [493.551530] Starting dynamic subtest: pipe-D-eDP-1 [494.848550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s) [494.850945] Subtest read-crc: SUCCESS (4.845s) [495.679569] [100/156] (525s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [495.778080] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [500.082585] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.310s) [501.300327] [101/156] (519s left) kms_psr (fbc-pr-cursor-plane-onoff) [501.385586] Starting subtest: fbc-pr-cursor-plane-onoff [501.390099] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [501.458345] [102/156] (519s left) kms_psr (fbc-psr2-cursor-blt) [501.547201] Starting subtest: fbc-psr2-cursor-blt [501.549514] Starting dynamic subtest: eDP-1 [501.553591] Dynamic subtest eDP-1: SKIP (0.000s) [501.557707] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [501.648883] [103/156] (519s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite) [501.748950] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite [501.753364] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s) [501.847934] [104/156] (519s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite) [501.942146] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite [501.946244] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [502.045288] [105/156] (519s left) kms_getfb (getfb-handle-closed) [502.142491] Starting subtest: getfb-handle-closed [502.144777] Subtest getfb-handle-closed: SUCCESS (0.000s) [502.236455] [106/156] (519s left) gem_exec_reloc (basic-write-gtt-active) [502.296004] Subtest basic-write-gtt-active: SKIP (0.000s) [502.373244] [107/156] (519s left) gem_lmem_swapping (massive) [502.408781] Subtest massive: SKIP (0.000s) [502.450332] [108/156] (519s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [502.539886] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [502.541843] Starting dynamic subtest: pipe-A-eDP-1 [502.560386] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [502.571721] Starting dynamic subtest: pipe-B-eDP-1 [502.589404] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [502.599415] Starting dynamic subtest: pipe-C-eDP-1 [502.616793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [502.628544] Starting dynamic subtest: pipe-D-eDP-1 [502.647232] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [502.650873] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [504.846092] [109/156] (516s left) kms_force_connector_basic (prune-stale-modes) [504.924591] Starting subtest: prune-stale-modes [505.371183] Subtest prune-stale-modes: SUCCESS (0.448s) [505.518032] [110/156] (516s left) kms_rmfb (rmfb-ioctl) [505.608578] Starting subtest: rmfb-ioctl [505.610516] Starting dynamic subtest: pipe-A-eDP-1 [505.711915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [505.723927] Starting dynamic subtest: pipe-B-eDP-1 [506.881115] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s) [506.894077] Starting dynamic subtest: pipe-C-eDP-1 [508.069500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [508.084094] Starting dynamic subtest: pipe-D-eDP-1 [509.277871] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.207s) [509.280158] Subtest rmfb-ioctl: SUCCESS (3.672s) [510.457706] [111/156] (511s left) gem_softpin (allocator-fork) [510.524776] Starting subtest: allocator-fork [512.793537] Subtest allocator-fork: SUCCESS (2.213s) [512.872490] [112/156] (508s left) gem_eio (in-flight-contexts-10ms) [513.106497] Starting subtest: in-flight-contexts-10ms [527.079483] Subtest in-flight-contexts-10ms: SUCCESS (13.969s) [527.249669] [113/156] (494s left) gen9_exec_parse (batch-without-end) [527.306605] Subtest batch-without-end: SKIP (0.000s) [527.384812] [114/156] (494s left) kms_cursor_crc (cursor-sliding-512x170) [527.675500] Starting subtest: cursor-sliding-512x170 [527.680278] Subtest cursor-sliding-512x170: SKIP (0.001s) [527.855840] [115/156] (493s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [527.960105] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [528.807142] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.848s) [528.981849] [116/156] (492s left) kms_frontbuffer_tracking (fbchdr-2p-rte) [529.079408] Starting subtest: fbchdr-2p-rte [529.083888] Subtest fbchdr-2p-rte: SKIP (0.000s) [529.183251] [117/156] (492s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [529.280514] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [529.285030] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [529.393137] [118/156] (492s left) kms_psr (psr2-cursor-blt) [529.483370] Starting subtest: psr2-cursor-blt [529.485664] Starting dynamic subtest: eDP-1 [531.198646] Dynamic subtest eDP-1: SUCCESS (1.713s) [531.201084] Subtest psr2-cursor-blt: SUCCESS (1.714s) [532.057445] [119/156] (489s left) api_intel_bb (object-noreloc-keep-cache-simple) [532.113255] Starting subtest: object-noreloc-keep-cache-simple [532.119405] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s) [532.251676] [120/156] (489s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [532.345830] Starting subtest: psr-2p-primscrn-spr-indfb-move [532.350104] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [532.459893] [121/156] (489s left) gem_render_copy (yf-tiled-ccs-to-x-tiled) [532.525583] Starting subtest: yf-tiled-ccs-to-x-tiled [532.530060] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s) [532.721297] [122/156] (489s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [532.782642] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [532.845176] [123/156] (489s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [532.949902] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [532.954159] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [533.069359] [124/156] (489s left) kms_big_fb (y-tiled-64bpp-rotate-0) [533.156391] Starting subtest: y-tiled-64bpp-rotate-0 [533.160678] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [533.257859] [125/156] (489s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary) [533.353439] Starting subtest: fbc-shrfb-scaledprimary [536.220285] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.872s) [537.383485] [126/156] (484s left) kms_vblank (ts-continuation-modeset-rpm) [537.479322] Starting subtest: ts-continuation-modeset-rpm [537.481178] Starting dynamic subtest: pipe-A-eDP-1 [540.027722] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.547s) [540.043873] Starting dynamic subtest: pipe-D-eDP-1 [542.215499] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.184s) [542.217766] Subtest ts-continuation-modeset-rpm: SUCCESS (4.735s) [543.062473] [127/156] (479s left) i915_drm_fdinfo (isolation) [543.105352] Starting subtest: isolation [543.108046] Starting dynamic subtest: rcs0 [543.144888] Dynamic subtest rcs0: SKIP (0.037s) [543.158445] Starting dynamic subtest: bcs0 [543.162960] Dynamic subtest bcs0: SKIP (0.001s) [543.174245] Starting dynamic subtest: vcs0 [543.178505] Dynamic subtest vcs0: SKIP (0.000s) [543.189636] Starting dynamic subtest: vcs1 [543.193744] Dynamic subtest vcs1: SKIP (0.000s) [543.203937] Starting dynamic subtest: vecs0 [543.208094] Dynamic subtest vecs0: SKIP (0.000s) [543.218003] Starting dynamic subtest: ccs0 [543.222010] Dynamic subtest ccs0: SKIP (0.000s) [543.226010] Subtest isolation: SKIP (0.045s) [543.264361] [128/156] (479s left) i915_pm_rps (min-max-config-idle) [543.331869] Starting subtest: min-max-config-idle [543.336163] Subtest min-max-config-idle: SKIP (0.001s) [543.444204] [129/156] (478s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy) [543.545872] Starting subtest: fbchdr-modesetfrombusy [543.550226] Subtest fbchdr-modesetfrombusy: SKIP (0.000s) [543.641692] [130/156] (478s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [543.744804] Starting subtest: plane-downscale-factor-0-5-with-rotation [543.747177] Starting dynamic subtest: pipe-A [543.767870] Dynamic subtest pipe-A: SKIP (0.017s) [543.780365] Starting dynamic subtest: pipe-B [543.797958] Dynamic subtest pipe-B: SKIP (0.030s) [543.809519] Starting dynamic subtest: pipe-C [543.826512] Dynamic subtest pipe-C: SKIP (0.029s) [543.837218] Starting dynamic subtest: pipe-D [543.855011] Dynamic subtest pipe-D: SKIP (0.029s) [543.859266] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.108s) [543.952209] [131/156] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [544.052308] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [544.056100] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [544.133710] [132/156] (478s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [544.228326] Starting subtest: fbcpsr-farfromfence-mmap-gtt [544.231780] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [544.340505] [133/156] (478s left) perf (short-reads) [544.422972] Starting subtest: short-reads [544.435269] Subtest short-reads: SUCCESS (0.012s) [544.483392] [134/156] (478s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite) [544.577486] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite [544.581208] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [544.675412] [135/156] (478s left) gem_ctx_persistence (engines-persistence) [544.732577] Starting subtest: engines-persistence [544.734608] Starting dynamic subtest: rcs0 [545.571605] Dynamic subtest rcs0: SUCCESS (0.838s) [545.585108] Starting dynamic subtest: bcs0 [546.316233] Dynamic subtest bcs0: SUCCESS (0.743s) [546.329844] Starting dynamic subtest: vcs0 [547.088496] Dynamic subtest vcs0: SUCCESS (0.770s) [547.102488] Starting dynamic subtest: vcs1 [547.833636] Dynamic subtest vcs1: SUCCESS (0.743s) [547.846737] Starting dynamic subtest: vecs0 [548.622418] Dynamic subtest vecs0: SUCCESS (0.786s) [548.635522] Starting dynamic subtest: ccs0 [549.391401] Dynamic subtest ccs0: SUCCESS (0.766s) [549.394223] Subtest engines-persistence: SUCCESS (4.658s) [549.473797] [136/156] (473s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y) [549.576665] Starting subtest: fbcpsrhdr-tiling-y [549.580658] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s) [549.667331] [137/156] (473s left) gem_ctx_persistence (smoketest) [549.717212] Starting subtest: smoketest [590.001282] Subtest smoketest: SUCCESS (40.270s) [590.080790] [138/156] (432s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [590.183950] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [590.188066] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [590.285672] [139/156] (432s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [590.383453] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [590.387601] Subtest hdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [590.495069] [140/156] (432s left) gem_exec_fence (syncobj-timeline-chain-engines) [591.057349] Starting subtest: syncobj-timeline-chain-engines [591.170932] Subtest syncobj-timeline-chain-engines: SUCCESS (0.114s) [592.178360] [141/156] (430s left) kms_chamelium_edid (vga-edid-read) [592.568046] Subtest vga-edid-read: SKIP (0.000s) [593.350755] [142/156] (429s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite) [593.464481] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite [593.468780] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [593.553034] [143/156] (429s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [593.650549] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [600.934095] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.290s) [601.059095] [144/156] (421s left) perf_pmu (multi-client) [601.097230] Starting subtest: multi-client [601.099542] Starting dynamic subtest: rcs0 [602.144850] Dynamic subtest rcs0: SUCCESS (1.046s) [602.159200] Starting dynamic subtest: bcs0 [603.196850] Dynamic subtest bcs0: SUCCESS (1.049s) [603.209599] Starting dynamic subtest: vcs0 [604.249977] Dynamic subtest vcs0: SUCCESS (1.050s) [604.263047] Starting dynamic subtest: vcs1 [606.092004] Dynamic subtest vcs1: SUCCESS (1.840s) [606.106312] Starting dynamic subtest: vecs0 [608.140038] Dynamic subtest vecs0: SUCCESS (2.044s) [608.152737] Starting dynamic subtest: ccs0 [610.124795] Dynamic subtest ccs0: SUCCESS (1.983s) [610.128015] Subtest multi-client: SUCCESS (9.029s) [610.259041] [145/156] (412s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [610.355879] Starting subtest: hdr-rgb565-draw-mmap-cpu [610.359789] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [610.460589] [146/156] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [610.548983] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [610.553176] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [610.647303] [147/156] (412s left) kms_psr (fbc-psr-sprite-mmap-gtt) [610.737399] Starting subtest: fbc-psr-sprite-mmap-gtt [610.739653] Starting dynamic subtest: eDP-1 [610.743680] Dynamic subtest eDP-1: SKIP (0.000s) [610.747637] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [610.810529] [148/156] (412s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [610.899308] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [610.903493] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [611.003834] [149/156] (412s left) gem_mmap_offset (bad-flags) [611.066911] Starting subtest: bad-flags [611.068820] Subtest bad-flags: SUCCESS (0.000s) [611.153558] [150/156] (412s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [611.218545] Starting subtest: etime-multi-wait-all-available-unsubmitted [611.327561] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s) [611.405072] [151/156] (411s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt) [611.505529] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt [611.509899] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [611.595083] [152/156] (411s left) kms_pm_rpm (modeset-lpsp) [613.218406] Starting subtest: modeset-lpsp [614.684469] Subtest modeset-lpsp: SUCCESS (1.469s) [614.815164] [153/156] (408s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [614.928337] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [614.932695] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [615.037851] [154/156] (408s left) syncobj_wait (invalid-signal-bad-pad) [615.092737] Starting subtest: invalid-signal-bad-pad [615.094743] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [615.208185] [155/156] (408s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [615.294903] Starting subtest: 2x-flip-vs-absolute-wf_vblank [615.305727] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.010s) [615.393862] [156/156] (408s left) gem_userptr_blits (userfault) [615.453897] Starting subtest: userfault [615.456393] Subtest userfault: SUCCESS (0.009s) [615.599626] Closing watchdogs results: parsing output: 0/ for test: kms_sequence results: parsing output: 1/ for test: kms_cursor_legacy results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_mmap_wc results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_content_protection results: parsing output: 6/ for test: prime_self_import results: parsing output: 7/ for test: core_setmaster results: parsing output: 8/ for test: gem_exec_create results: parsing output: 9/ for test: kms_ccs results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: gem_render_copy results: parsing output: 13/ for test: gem_wait results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_reloc results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: kms_chamelium_color results: parsing output: 21/ for test: gem_mmap_gtt results: parsing output: 22/ for test: kms_plane_scaling results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_getfb results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: gem_exec_balancer results: parsing output: 29/ for test: gem_exec_reloc results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_legacy_colorkey results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: gem_tiled_blits results: parsing output: 34/ for test: kms_setmode results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_flip_scaled_crc results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_exec_whisper results: parsing output: 41/ for test: kms_addfb_basic results: parsing output: 42/ for test: i915_drm_fdinfo results: parsing output: 43/ for test: kms_invalid_mode results: parsing output: 44/ for test: kms_plane results: parsing output: 45/ for test: i915_suspend results: parsing output: 46/ for test: kms_plane results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: gem_mmap_wc results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: sriov_basic results: parsing output: 53/ for test: kms_draw_crc results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: prime_mmap results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_color_pipeline results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: kms_chamelium_hpd results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_close_race results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_exec_schedule results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_atomic results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_atomic_interruptible results: parsing output: 73/ for test: gem_sync results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: vgem_basic results: parsing output: 77/ for test: api_intel_allocator results: parsing output: 78/ for test: gem_busy results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_params results: parsing output: 83/ for test: kms_prop_blob results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: kms_ccs results: parsing output: 86/ for test: gem_pipe_control_store_loop results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: gem_pxp results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: gem_exec_balancer results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: perf results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: syncobj_basic results: parsing output: 95/ for test: prime_vgem results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_pipe_crc_basic results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_getfb results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: gem_lmem_swapping results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_rmfb results: parsing output: 110/ for test: gem_softpin results: parsing output: 111/ for test: gem_eio results: parsing output: 112/ for test: gen9_exec_parse results: parsing output: 113/ for test: kms_cursor_crc results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_big_fb results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: api_intel_bb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: i915_drm_fdinfo results: parsing output: 127/ for test: i915_pm_rps results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_plane_scaling results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: perf results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: gem_ctx_persistence results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: gem_ctx_persistence results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: gem_exec_fence results: parsing output: 140/ for test: kms_chamelium_edid results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: perf_pmu results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_psr results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: gem_mmap_offset results: parsing output: 149/ for test: syncobj_timeline results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_pm_rpm results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: syncobj_wait results: parsing output: 154/ for test: kms_flip results: parsing output: 155/ for test: gem_userptr_blits Done.