[85.963163] Initializing watchdogs [85.963369] /dev/watchdog0 [86.004148] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [86.018714] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [86.025812] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [86.033992] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [86.261889] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [86.268779] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [86.436524] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [86.646982] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [86.659057] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [86.775322] [003/133] (959s left) kms_flip (flip-vs-rmfb-interruptible) [86.983222] Starting subtest: flip-vs-rmfb-interruptible [86.987671] Starting dynamic subtest: A-HDMI-A1 [92.663217] Dynamic subtest A-HDMI-A1: SUCCESS (5.668s) [92.685360] Starting dynamic subtest: B-HDMI-A1 [98.010026] Dynamic subtest B-HDMI-A1: SUCCESS (5.341s) [98.031358] Starting dynamic subtest: C-HDMI-A1 [103.350432] Dynamic subtest C-HDMI-A1: SUCCESS (5.331s) [103.371314] Starting dynamic subtest: A-HDMI-A2 [108.696218] Dynamic subtest A-HDMI-A2: SUCCESS (5.341s) [108.718353] Starting dynamic subtest: B-HDMI-A2 [114.112245] Dynamic subtest B-HDMI-A2: SUCCESS (5.409s) [114.133297] Starting dynamic subtest: C-HDMI-A2 [119.455095] Dynamic subtest C-HDMI-A2: SUCCESS (5.338s) [119.461108] Subtest flip-vs-rmfb-interruptible: SUCCESS (32.451s) [119.939552] [004/133] (926s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [120.128132] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [120.132197] Starting dynamic subtest: pipe-A-HDMI-A-1 [120.172541] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [120.211577] Starting dynamic subtest: pipe-A-HDMI-A-2 [120.263063] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s) [120.283401] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.314439] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [120.335035] Starting dynamic subtest: pipe-B-HDMI-A-2 [120.363663] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [120.381783] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.410446] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [120.428568] Starting dynamic subtest: pipe-C-HDMI-A-2 [120.462098] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [120.467592] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.033s) [121.126169] [005/133] (925s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait) [123.038189] Starting subtest: modeset-non-lpsp-stress-no-wait [126.450176] Subtest modeset-non-lpsp-stress-no-wait: SUCCESS (3.406s) [126.731119] [006/133] (920s left) kms_async_flips (async-flip-with-page-flip-events-linear) [126.932137] Starting subtest: async-flip-with-page-flip-events-linear [127.522312] Subtest async-flip-with-page-flip-events-linear: SKIP (0.592s) [127.882710] [007/133] (919s left) syncobj_wait (reset-multiple-signaled) [127.999525] Starting subtest: reset-multiple-signaled [128.002891] Subtest reset-multiple-signaled: SUCCESS (0.003s) [128.144207] [008/133] (919s left) kms_cursor_legacy (flip-vs-cursor-atomic) [128.333773] Starting subtest: flip-vs-cursor-atomic [146.432152] Subtest flip-vs-cursor-atomic: SUCCESS (18.093s) [146.724856] [009/133] (900s left) gem_eio (context-create) [146.884613] Starting subtest: context-create [146.945109] Subtest context-create: SUCCESS (0.059s) [147.220544] [010/133] (900s left) kms_atomic (atomic-plane-damage) [147.415029] Starting subtest: atomic-plane-damage [148.421318] Subtest atomic-plane-damage: SKIP (1.010s) [148.919276] [011/133] (898s left) kms_pm_dc (dc5-dpms-negative) [150.117879] Starting subtest: dc5-dpms-negative [154.357376] Subtest dc5-dpms-negative: SUCCESS (4.238s) [154.496166] [012/133] (893s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [154.722059] Starting subtest: fbc-rgb565-draw-blt [157.560051] Subtest fbc-rgb565-draw-blt: SUCCESS (2.844s) [157.834876] [013/133] (889s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [157.945052] Starting subtest: write-cpu-read-wc-unflushed [158.111663] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.106s) [158.531213] [014/133] (889s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [159.022878] Starting subtest: flip-vs-cursor-busy-crc-atomic [159.874720] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (1.044s) [160.170235] [015/133] (888s left) gem_partial_pwrite_pread (reads-display) [160.309706] Starting subtest: reads-display [166.861582] Subtest reads-display: SUCCESS (6.560s) [167.035636] [016/133] (881s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [167.253470] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [167.261439] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.001s) [167.389343] [017/133] (881s left) gem_userptr_blits (sd-probe) [167.522207] Starting subtest: sd-probe [167.525575] Subtest sd-probe: SUCCESS (0.001s) [167.718590] [018/133] (880s left) gem_mmap_wc (write-read-distinct) [167.834922] Starting subtest: write-read-distinct [167.839681] Subtest write-read-distinct: SUCCESS (0.008s) [167.982890] [019/133] (880s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [168.184110] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [168.280219] [020/133] (880s left) kms_content_protection (atomic-dpms-hdcp14) [168.498864] Starting subtest: atomic-dpms-hdcp14 [168.533266] Subtest atomic-dpms-hdcp14: SKIP (0.030s) [168.667735] [021/133] (880s left) kms_busy (extended-modeset-hang-oldfb) [168.883111] Starting subtest: extended-modeset-hang-oldfb [168.887122] Starting dynamic subtest: pipe-A [173.194863] Dynamic subtest pipe-A: SUCCESS (4.312s) [173.223056] Starting dynamic subtest: pipe-C [177.193215] Dynamic subtest pipe-C: SUCCESS (3.985s) [177.197250] Subtest extended-modeset-hang-oldfb: SUCCESS (8.316s) [177.581037] [022/133] (871s left) perf_pmu (invalid-init) [177.703641] Starting subtest: invalid-init [177.707169] Subtest invalid-init: SUCCESS (0.001s) [177.842266] [023/133] (871s left) kms_dp_link_training (uhbr-mst) [178.034196] Starting subtest: uhbr-mst [178.040681] Subtest uhbr-mst: SKIP (0.000s) [178.173156] [024/133] (870s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [178.373213] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [178.379101] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [180.597412] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (2.218s) [180.622324] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [182.613128] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (2.010s) [182.640632] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [184.536203] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (1.914s) [184.543322] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (6.168s) [184.881912] [025/133] (864s left) gem_exec_fence (syncobj-wait) [185.538187] Starting subtest: syncobj-wait [185.567346] Subtest syncobj-wait: SUCCESS (0.033s) [185.964735] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true [185.972236] [026/133] (863s left) kms_plane_alpha_blend (alpha-opaque-fb) [186.155084] Starting subtest: alpha-opaque-fb [186.311212] Starting dynamic subtest: pipe-A-HDMI-A-1 [187.775705] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.479s) [187.797906] Starting dynamic subtest: pipe-C-HDMI-A-1 [188.896191] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.352s) [188.899988] Subtest alpha-opaque-fb: FAIL (1.996s) [189.014217] [027/133] (860s left) kms_psr (psr2-primary-mmap-gtt) [189.208074] Subtest psr2-primary-mmap-gtt: SKIP (0.000s) [189.322147] [028/133] (860s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [189.437270] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [189.542421] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [189.720981] [029/133] (859s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [189.906067] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [190.141669] Starting dynamic subtest: pipe-A-plane-0 [190.841927] Dynamic subtest pipe-A-plane-0: SUCCESS (0.698s) [190.864193] Starting dynamic subtest: pipe-A-plane-1 [191.495060] Dynamic subtest pipe-A-plane-1: SUCCESS (0.646s) [191.516554] Starting dynamic subtest: pipe-A-plane-2 [191.974676] Dynamic subtest pipe-A-plane-2: SUCCESS (0.480s) [191.996689] Starting dynamic subtest: pipe-A-plane-3 [192.457906] Dynamic subtest pipe-A-plane-3: SUCCESS (0.480s) [192.930067] Starting dynamic subtest: pipe-B-plane-0 [194.147506] Dynamic subtest pipe-B-plane-0: SUCCESS (0.649s) [194.170438] Starting dynamic subtest: pipe-B-plane-1 [194.254023] Dynamic subtest pipe-B-plane-1: SUCCESS (0.664s) [194.277457] Starting dynamic subtest: pipe-B-plane-2 [194.612207] Dynamic subtest pipe-B-plane-2: SUCCESS (0.480s) [194.633775] Starting dynamic subtest: pipe-B-plane-3 [195.095225] Dynamic subtest pipe-B-plane-3: SUCCESS (0.480s) [195.314647] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.406s) [195.693386] [030/133] (854s left) syncobj_wait (invalid-reset-one-illegal-handle) [195.816353] Starting subtest: invalid-reset-one-illegal-handle [195.820149] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.001s) [195.960403] [031/133] (853s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [196.147375] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [196.151341] Starting dynamic subtest: pipe-A [196.495094] Dynamic subtest pipe-A: SUCCESS (0.346s) [196.537364] Starting dynamic subtest: pipe-B [196.945112] Dynamic subtest pipe-B: SUCCESS (0.446s) [196.969062] Starting dynamic subtest: pipe-C [197.023465] Dynamic subtest pipe-C: SUCCESS (0.070s) [197.026779] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.873s) [197.506362] [032/133] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [197.716911] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [197.723193] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [197.877131] [033/133] (852s left) gem_eio (reset-stress) [198.025062] Starting subtest: reset-stress [198.030578] Starting dynamic subtest: render [199.852095] Dynamic subtest render: SUCCESS (1.830s) [199.883186] Starting dynamic subtest: bsd [201.749501] Dynamic subtest bsd: SUCCESS (1.895s) [201.780659] Starting dynamic subtest: blt [204.532844] Dynamic subtest blt: SUCCESS (2.776s) [204.558889] Starting dynamic subtest: vebox [206.382087] Dynamic subtest vebox: SUCCESS (1.846s) [206.386111] Subtest reset-stress: SUCCESS (8.367s) [206.644274] [034/133] (843s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [206.856405] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [206.864500] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [207.014485] [035/133] (843s left) gem_exec_parallel (fds) [207.147182] Starting subtest: fds [207.150761] Starting dynamic subtest: rcs0 [212.146148] Dynamic subtest rcs0: SUCCESS (4.994s) [212.168806] Starting dynamic subtest: bcs0 [221.446689] Dynamic subtest bcs0: SUCCESS (9.297s) [221.477366] Starting dynamic subtest: vcs0 [226.321861] Dynamic subtest vcs0: SUCCESS (4.871s) [226.345362] Starting dynamic subtest: vecs0 [231.164314] Dynamic subtest vecs0: SUCCESS (4.838s) [231.168267] Subtest fds: SUCCESS (24.017s) [231.437887] [036/133] (818s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [231.656289] Starting subtest: psr-2p-pri-indfb-multidraw [231.664834] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [231.822476] [037/133] (818s left) kms_big_fb (y-tiled-32bpp-rotate-180) [232.052185] Starting subtest: y-tiled-32bpp-rotate-180 [237.178116] Subtest y-tiled-32bpp-rotate-180: SUCCESS (5.126s) [237.583151] [038/133] (812s left) gem_softpin (overlap) [237.711595] Starting subtest: overlap [240.277294] Subtest overlap: SUCCESS (2.566s) [240.429160] [039/133] (810s left) syncobj_timeline (invalid-wait-illegal-handle) [240.545105] Starting subtest: invalid-wait-illegal-handle [240.548692] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [240.695371] [040/133] (810s left) kms_psr (fbc-pr-sprite-mmap-gtt) [240.892777] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [241.008331] [041/133] (809s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [241.117780] Starting subtest: cpuset-basic-small-copy-XY [247.102217] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.984s) [247.258769] [042/133] (803s left) kms_cursor_crc (cursor-rapid-movement-64x21) [247.627584] Starting subtest: cursor-rapid-movement-64x21 [247.670056] Starting dynamic subtest: pipe-A-HDMI-A-1 [248.650051] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.986s) [248.786270] Starting dynamic subtest: pipe-C-HDMI-A-1 [249.357702] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.617s) [249.362531] Subtest cursor-rapid-movement-64x21: SUCCESS (1.734s) [249.733474] [043/133] (801s left) gem_exec_flush (basic-wb-rw-default) [249.875123] Starting subtest: basic-wb-rw-default [255.293334] Subtest basic-wb-rw-default: SUCCESS (5.418s) [255.561313] [044/133] (795s left) gem_linear_blits (normal) [255.786326] Starting subtest: normal [271.271134] Subtest normal: SUCCESS (15.486s) [271.432610] [045/133] (779s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [271.758552] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [271.764146] Starting dynamic subtest: pipe-A-HDMI-A-1 [271.780461] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [271.833081] Starting dynamic subtest: pipe-A-HDMI-A-2 [271.858540] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [271.894199] Starting dynamic subtest: pipe-B-HDMI-A-1 [271.907755] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [271.932230] Starting dynamic subtest: pipe-B-HDMI-A-2 [271.945129] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [271.969454] Starting dynamic subtest: pipe-C-HDMI-A-1 [271.982102] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [272.005659] Starting dynamic subtest: pipe-C-HDMI-A-2 [272.018507] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [272.024698] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.033s) [272.735512] [046/133] (778s left) syncobj_timeline (wait-all-for-submit-complex) [272.877514] Starting subtest: wait-all-for-submit-complex [273.103776] Subtest wait-all-for-submit-complex: SUCCESS (0.225s) [273.255234] [047/133] (778s left) gem_spin_batch (legacy-resubmit) [273.381167] Starting subtest: legacy-resubmit [273.386353] Starting dynamic subtest: default [273.390148] Dynamic subtest default: SUCCESS (0.005s) [273.416781] Starting dynamic subtest: render [273.420275] Dynamic subtest render: SUCCESS (0.004s) [273.447118] Starting dynamic subtest: bsd [273.450677] Dynamic subtest bsd: SUCCESS (0.007s) [273.474847] Starting dynamic subtest: bsd1 [273.479199] Dynamic subtest bsd1: SUCCESS (0.007s) [273.504436] Starting dynamic subtest: blt [273.508307] Dynamic subtest blt: SUCCESS (0.008s) [273.533214] Starting dynamic subtest: vebox [273.537135] Dynamic subtest vebox: SUCCESS (0.007s) [273.541125] Subtest legacy-resubmit: SUCCESS (0.067s) [273.719712] [048/133] (777s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [273.924377] Starting subtest: blocking-absolute-wf_vblank-interruptible [273.933890] Starting dynamic subtest: A-HDMI-A1 [279.663402] Dynamic subtest A-HDMI-A1: SUCCESS (5.729s) [279.689949] Starting dynamic subtest: B-HDMI-A1 [285.035185] Dynamic subtest B-HDMI-A1: SUCCESS (5.362s) [285.059509] Starting dynamic subtest: C-HDMI-A1 [290.393392] Dynamic subtest C-HDMI-A1: SUCCESS (5.355s) [290.419995] Starting dynamic subtest: A-HDMI-A2 [295.939211] Dynamic subtest A-HDMI-A2: SUCCESS (5.542s) [295.965238] Starting dynamic subtest: B-HDMI-A2 [301.464364] Dynamic subtest B-HDMI-A2: SUCCESS (5.521s) [301.498705] Starting dynamic subtest: C-HDMI-A2 [307.008106] Dynamic subtest C-HDMI-A2: SUCCESS (5.533s) [307.013186] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (33.084s) [307.580315] [049/133] (744s left) kms_draw_crc (draw-method-mmap-gtt) [307.777179] Starting subtest: draw-method-mmap-gtt [307.781107] Starting dynamic subtest: xrgb8888-untiled [308.253861] Dynamic subtest xrgb8888-untiled: SUCCESS (0.480s) [308.280400] Starting dynamic subtest: rgb565-untiled [308.501654] Dynamic subtest rgb565-untiled: SUCCESS (0.245s) [308.526937] Starting dynamic subtest: xrgb2101010-untiled [308.770080] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.264s) [308.794930] Starting dynamic subtest: xbgr16161616f-untiled [309.036728] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.263s) [309.061325] Starting dynamic subtest: xrgb8888-xtiled [309.185770] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.146s) [309.217195] Starting dynamic subtest: rgb565-xtiled [309.339162] Dynamic subtest rgb565-xtiled: SUCCESS (0.145s) [309.364684] Starting dynamic subtest: xrgb2101010-xtiled [309.470685] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.129s) [309.496193] Starting dynamic subtest: xbgr16161616f-xtiled [309.602913] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.128s) [309.627976] Starting dynamic subtest: xrgb8888-ytiled [309.753760] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.147s) [309.778351] Starting dynamic subtest: rgb565-ytiled [309.903057] Dynamic subtest rgb565-ytiled: SUCCESS (0.145s) [309.933883] Starting dynamic subtest: xrgb2101010-ytiled [310.039170] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.128s) [310.068390] Starting dynamic subtest: xbgr16161616f-ytiled [310.187139] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.147s) [310.191192] Subtest draw-method-mmap-gtt: SUCCESS (2.416s) [310.441815] [050/133] (741s left) gem_exec_reloc (basic-write-wc-active) [310.562615] Starting subtest: basic-write-wc-active [310.703864] Subtest basic-write-wc-active: SUCCESS (0.140s) [310.941562] [051/133] (740s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [311.154777] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [311.162929] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [311.306671] [052/133] (740s left) kms_plane_multiple (2x-tiling-y) [311.504617] Starting subtest: 2x-tiling-y [311.520032] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2 [312.642667] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.129s) [312.716236] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-C-HDMI-A-2 [313.725445] Dynamic subtest pipe-A-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.044s) [313.791043] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-B-HDMI-A-1 [315.066111] Dynamic subtest pipe-A-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.297s) [315.133356] Starting dynamic subtest: pipe-A-HDMI-A-2-pipe-C-HDMI-A-1 [316.165091] Dynamic subtest pipe-A-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.078s) [316.240501] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2 [317.597593] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.391s) [317.662313] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-C-HDMI-A-2 [318.763543] Dynamic subtest pipe-B-HDMI-A-1-pipe-C-HDMI-A-2: SUCCESS (1.094s) [318.861406] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-A-HDMI-A-1 [320.018738] Dynamic subtest pipe-B-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.267s) [320.084515] Starting dynamic subtest: pipe-B-HDMI-A-2-pipe-C-HDMI-A-1 [321.169821] Dynamic subtest pipe-B-HDMI-A-2-pipe-C-HDMI-A-1: SUCCESS (1.130s) [321.221359] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-A-HDMI-A-2 [322.233513] Dynamic subtest pipe-C-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (1.040s) [322.306556] Starting dynamic subtest: pipe-C-HDMI-A-1-pipe-B-HDMI-A-2 [323.327801] Dynamic subtest pipe-C-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (1.055s) [323.393354] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-A-HDMI-A-1 [324.631181] Dynamic subtest pipe-C-HDMI-A-2-pipe-A-HDMI-A-1: SUCCESS (1.282s) [324.712304] Starting dynamic subtest: pipe-C-HDMI-A-2-pipe-B-HDMI-A-1 [325.778554] Dynamic subtest pipe-C-HDMI-A-2-pipe-B-HDMI-A-1: SUCCESS (1.105s) [325.799209] Subtest 2x-tiling-y: SUCCESS (14.290s) [326.587738] [053/133] (725s left) kms_joiner (basic-force-big-joiner) [326.818764] Starting subtest: basic-force-big-joiner [326.825627] Subtest basic-force-big-joiner: SKIP (0.000s) [326.960133] [054/133] (725s left) gem_ctx_persistence (legacy-engines-cleanup) [327.081997] Starting subtest: legacy-engines-cleanup [327.085961] Starting dynamic subtest: render [327.106510] Dynamic subtest render: SUCCESS (0.020s) [327.132869] Starting dynamic subtest: bsd [327.136269] Dynamic subtest bsd: SUCCESS (0.014s) [327.162705] Starting dynamic subtest: blt [327.166420] Dynamic subtest blt: SUCCESS (0.029s) [327.191928] Starting dynamic subtest: vebox [327.196271] Dynamic subtest vebox: SUCCESS (0.027s) [327.199924] Subtest legacy-engines-cleanup: SUCCESS (0.107s) [327.340122] [055/133] (725s left) gem_ctx_isolation (dirty-create) [327.473733] Starting subtest: dirty-create [327.477330] Starting dynamic subtest: rcs0 [328.025034] Dynamic subtest rcs0: SUCCESS (0.550s) [328.060273] Starting dynamic subtest: bcs0 [328.949640] Dynamic subtest bcs0: SUCCESS (0.914s) [328.978402] Starting dynamic subtest: vcs0 [329.501153] Dynamic subtest vcs0: SUCCESS (0.552s) [329.531269] Starting dynamic subtest: vecs0 [330.046538] Dynamic subtest vecs0: SUCCESS (0.540s) [330.050338] Subtest dirty-create: SUCCESS (2.574s) [330.305202] [056/133] (722s left) kms_addfb_basic (no-handle) [330.418183] Starting subtest: no-handle [330.421271] Subtest no-handle: SUCCESS (0.000s) [330.659215] [057/133] (721s left) kms_vblank (wait-forked-busy) [330.846490] Starting subtest: wait-forked-busy [330.852108] Starting dynamic subtest: pipe-A-HDMI-A-1 [333.735338] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.884s) [333.793406] Starting dynamic subtest: pipe-A-HDMI-A-2 [336.380062] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.636s) [336.414023] Starting dynamic subtest: pipe-C-HDMI-A-1 [338.975686] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.585s) [339.015718] Starting dynamic subtest: pipe-C-HDMI-A-2 [341.577406] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.594s) [341.583501] Subtest wait-forked-busy: SUCCESS (10.732s) [341.934698] [058/133] (710s left) api_intel_bb (reset-flags) [342.050389] Starting subtest: reset-flags [342.064330] Subtest reset-flags: SUCCESS (0.017s) [342.231283] [059/133] (710s left) gem_create (create-ext-set-pat) [342.461338] Starting subtest: create-ext-set-pat [342.468269] Subtest create-ext-set-pat: SKIP (0.000s) [342.626158] [060/133] (710s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [342.846611] Starting subtest: fbcpsr-rgb101010-draw-render [342.853212] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [342.999817] [061/133] (709s left) i915_hangman (engine-error-state-capture) [343.146150] Starting subtest: engine-error-state-capture [343.153369] Starting dynamic subtest: rcs0 [347.464202] Dynamic subtest rcs0: SUCCESS (4.322s) [347.491343] Starting dynamic subtest: bcs0 [351.504973] Dynamic subtest bcs0: SUCCESS (4.033s) [351.529423] Starting dynamic subtest: vcs0 [355.464066] Dynamic subtest vcs0: SUCCESS (3.959s) [355.489808] Starting dynamic subtest: vecs0 [359.500969] Dynamic subtest vecs0: SUCCESS (4.032s) [359.516823] Subtest engine-error-state-capture: SUCCESS (16.362s) [359.666847] [062/133] (693s left) fbdev (nullptr) [359.796094] Starting subtest: nullptr [359.799759] Subtest nullptr: SUCCESS (0.000s) [359.932114] [063/133] (693s left) gem_exec_schedule (preempt-queue-contexts) [360.085236] Starting subtest: preempt-queue-contexts [360.089230] Starting dynamic subtest: rcs0 [360.864075] Dynamic subtest rcs0: SUCCESS (0.730s) [360.929879] Starting dynamic subtest: bcs0 [361.645975] Dynamic subtest bcs0: SUCCESS (0.767s) [361.672188] Starting dynamic subtest: vcs0 [362.338345] Dynamic subtest vcs0: SUCCESS (0.758s) [362.387067] Starting dynamic subtest: vecs0 [363.116706] Dynamic subtest vecs0: SUCCESS (0.766s) [363.124162] Subtest preempt-queue-contexts: SUCCESS (3.039s) [363.577861] [064/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [363.792671] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [363.799794] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [364.018296] [065/133] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [364.237146] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [364.245541] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [364.425967] [066/133] (689s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [364.552180] Starting subtest: yf-tiled-to-vebox-yf-tiled [364.560160] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [364.816221] [067/133] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu) [365.035083] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu [367.592147] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.560s) [367.828286] [068/133] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [368.043479] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [368.049780] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [368.194869] [069/133] (685s left) kms_chamelium_audio (hdmi-audio) [368.812217] Subtest hdmi-audio: SKIP (0.000s) [369.095627] [070/133] (684s left) kms_setmode (clone-exclusive-crtc) [369.214507] Starting subtest: clone-exclusive-crtc [369.679055] Starting dynamic subtest: pipe-A-HDMI-A-1-pipe-B-HDMI-A-2 [369.964077] Dynamic subtest pipe-A-HDMI-A-1-pipe-B-HDMI-A-2: SUCCESS (0.283s) [370.487252] Starting dynamic subtest: pipe-B-HDMI-A-1-pipe-A-HDMI-A-2 [370.788483] Dynamic subtest pipe-B-HDMI-A-1-pipe-A-HDMI-A-2: SUCCESS (0.315s) [371.210122] Subtest clone-exclusive-crtc: SUCCESS (2.002s) [371.575100] [071/133] (682s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [372.295832] Starting subtest: syncobj-timeline-multiple-ext-nodes [372.299953] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [372.576380] [072/133] (681s left) kms_psr (fbc-psr2-suspend) [372.773061] Subtest fbc-psr2-suspend: SKIP (0.000s) [372.905817] [073/133] (681s left) i915_pm_rps (fence-order) [373.043415] Starting subtest: fence-order [375.437116] Subtest fence-order: SUCCESS (2.392s) [375.594210] [074/133] (678s left) gem_lmem_swapping (basic) [375.710922] Subtest basic: SKIP (0.000s) [375.835162] [075/133] (678s left) kms_sequence (get-idle) [376.023089] Starting subtest: get-idle [376.026402] Starting dynamic subtest: pipe-A-HDMI-A-1 [378.798251] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.771s) [378.847628] Starting dynamic subtest: pipe-A-HDMI-A-2 [381.304170] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.497s) [381.351282] Starting dynamic subtest: pipe-B-HDMI-A-1 [383.740369] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.438s) [383.805228] Starting dynamic subtest: pipe-B-HDMI-A-2 [386.216133] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.467s) [386.249079] Starting dynamic subtest: pipe-C-HDMI-A-1 [388.689081] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.463s) [388.730295] Starting dynamic subtest: pipe-C-HDMI-A-2 [391.190416] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.490s) [391.195482] Subtest get-idle: SUCCESS (15.169s) [391.522813] [076/133] (663s left) vgem_basic (bad-flag) [391.667372] Starting subtest: bad-flag [391.671678] Subtest bad-flag: SUCCESS (0.000s) [391.790913] [077/133] (663s left) gem_eio (in-flight-contexts-1us) [391.929606] Starting subtest: in-flight-contexts-1us [404.014912] Subtest in-flight-contexts-1us: SUCCESS (12.081s) [404.254281] [078/133] (650s left) gem_exec_schedule (preempt-queue-contexts-chain) [404.406229] Starting subtest: preempt-queue-contexts-chain [404.411070] Starting dynamic subtest: rcs0 [405.203953] Dynamic subtest rcs0: SUCCESS (0.796s) [405.233093] Starting dynamic subtest: bcs0 [406.022847] Dynamic subtest bcs0: SUCCESS (0.815s) [406.080439] Starting dynamic subtest: vcs0 [406.887918] Dynamic subtest vcs0: SUCCESS (0.860s) [406.924465] Starting dynamic subtest: vecs0 [407.705094] Dynamic subtest vecs0: SUCCESS (0.811s) [407.710829] Subtest preempt-queue-contexts-chain: SUCCESS (3.303s) [408.153169] [079/133] (646s left) gem_userptr_blits (process-exit-busy) [408.289035] Starting subtest: process-exit-busy [408.334355] Subtest process-exit-busy: SUCCESS (0.043s) [408.524389] [080/133] (646s left) kms_psr (pr-cursor-mmap-gtt) [408.713063] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [408.835488] [081/133] (646s left) kms_chamelium_hpd (dp-hpd-storm) [409.473693] Subtest dp-hpd-storm: SKIP (0.000s) [409.788525] [082/133] (645s left) dmabuf_sync_file (export-basic) [409.918817] Starting subtest: export-basic [409.923527] Subtest export-basic: SUCCESS (0.004s) [410.062237] [083/133] (645s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [410.266968] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [410.274955] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [410.415546] [084/133] (645s left) gem_exec_reloc (basic-wc-active) [410.535665] Starting subtest: basic-wc-active [410.679067] Subtest basic-wc-active: SUCCESS (0.140s) [410.915823] [085/133] (644s left) kms_plane_scaling (intel-max-src-size) [411.114375] Starting subtest: intel-max-src-size [411.155381] Starting dynamic subtest: pipe-A-HDMI-A-1 [411.236875] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.085s) [411.327529] Starting dynamic subtest: pipe-A-HDMI-A-2 [411.403957] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.125s) [411.408284] Subtest intel-max-src-size: SUCCESS (0.289s) [411.615123] [086/133] (644s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [411.843134] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [415.461545] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.618s) [415.663216] [087/133] (640s left) gem_pwrite (basic-self) [415.771741] Starting subtest: basic-self [415.976945] Subtest basic-self: SUCCESS (0.207s) [416.144863] [088/133] (639s left) gem_mmap_offset (bad-extensions) [416.262020] Starting subtest: bad-extensions [416.265394] Subtest bad-extensions: SUCCESS (0.000s) [416.414923] [089/133] (639s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [416.609749] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [416.613347] Starting dynamic subtest: pipe-A-HDMI-A-1 [416.650475] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [416.699577] Starting dynamic subtest: pipe-A-HDMI-A-2 [416.738082] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [416.772534] Starting dynamic subtest: pipe-B-HDMI-A-1 [416.806177] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [416.835989] Starting dynamic subtest: pipe-B-HDMI-A-2 [416.869687] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [416.895880] Starting dynamic subtest: pipe-C-HDMI-A-1 [416.928034] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [416.958945] Starting dynamic subtest: pipe-C-HDMI-A-2 [416.991227] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [416.997705] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.034s) [417.729376] [090/133] (638s left) drm_read (fault-buffer) [418.155481] Starting subtest: fault-buffer [418.158966] Subtest fault-buffer: SUCCESS (0.003s) [418.451085] [091/133] (637s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [418.561196] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [418.564494] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.002s) [418.746215] [092/133] (637s left) kms_lease (lease-invalid-connector) [418.942895] Starting subtest: lease-invalid-connector [418.947103] Starting dynamic subtest: pipe-A-HDMI-A-1 [418.950989] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [419.002633] Starting dynamic subtest: pipe-A-HDMI-A-2 [419.007367] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.000s) [419.033411] Starting dynamic subtest: pipe-B-HDMI-A-1 [419.036806] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [419.067048] Starting dynamic subtest: pipe-B-HDMI-A-2 [419.072324] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [419.098289] Starting dynamic subtest: pipe-C-HDMI-A-1 [419.101717] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s) [419.127401] Starting dynamic subtest: pipe-C-HDMI-A-2 [419.130944] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.000s) [419.134994] Subtest lease-invalid-connector: SUCCESS (0.050s) [419.237123] [093/133] (637s left) gem_userptr_blits (unsync-overlap) [419.370390] Subtest unsync-overlap: SKIP (0.000s) [419.566222] [094/133] (637s left) kms_flip (flip-vs-suspend-interruptible) [419.782185] Starting subtest: flip-vs-suspend-interruptible [419.787091] Starting dynamic subtest: A-HDMI-A1