[134.566185] Initializing watchdogs [134.566367] /dev/watchdog0 [134.606794] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [134.621765] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [134.628529] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [134.633532] [001/133] (960s left) kms_fbcon_fbt (psr) [134.783228] Starting subtest: psr [134.789361] Subtest psr: SKIP (0.001s) [134.972764] [002/133] (960s left) syncobj_timeline (invalid-signal-illegal-point) [135.075730] Starting subtest: invalid-signal-illegal-point [135.077180] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [135.225215] [003/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [135.419086] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [138.584872] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (3.163s) [138.887528] [004/133] (956s left) i915_query (query-garbage) [138.995329] Starting subtest: query-garbage [138.997095] Subtest query-garbage: SUCCESS (0.000s) [139.112149] [005/133] (956s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [139.314298] Starting subtest: fbc-rgb101010-draw-blt [142.334874] Subtest fbc-rgb101010-draw-blt: SUCCESS (3.021s) [142.596530] [006/133] (952s left) i915_drm_fdinfo (all-busy-check-all) [142.709736] Starting subtest: all-busy-check-all [143.239833] Subtest all-busy-check-all: SUCCESS (0.526s) [143.362371] [007/133] (952s left) kms_psr (fbc-psr-no-drrs) [143.549426] Subtest fbc-psr-no-drrs: SKIP (0.000s) [143.633419] [008/133] (952s left) api_intel_bb (blit-reloc-purge-cache) [143.736586] Starting subtest: blit-reloc-purge-cache [143.758332] Subtest blit-reloc-purge-cache: SUCCESS (0.022s) [143.910252] [009/133] (951s left) gem_eio (wait-1us) [144.052343] Starting subtest: wait-1us [144.165260] Subtest wait-1us: SUCCESS (0.109s) [144.392338] [010/133] (951s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [144.591185] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [144.594912] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [144.713243] [011/133] (951s left) gem_tiled_partial_pwrite_pread (reads) [144.829828] Starting subtest: reads [146.213247] Subtest reads: SUCCESS (1.384s) [146.347285] [012/133] (949s left) gem_exec_parallel (contexts) [146.472654] Starting subtest: contexts [146.473725] Starting dynamic subtest: rcs0 [151.127023] Dynamic subtest rcs0: SUCCESS (4.655s) [151.162133] Starting dynamic subtest: bcs0 [155.844519] Dynamic subtest bcs0: SUCCESS (4.717s) [155.868257] Starting dynamic subtest: vcs0 [159.605082] Dynamic subtest vcs0: SUCCESS (3.757s) [159.623249] Starting dynamic subtest: vecs0 [163.483891] Dynamic subtest vecs0: SUCCESS (3.882s) [163.485067] Subtest contexts: SUCCESS (17.016s) [163.739529] [013/133] (932s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [163.948075] Starting subtest: yf-tiled-8bpp-rotate-0 [163.950270] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [164.070467] [014/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [164.282489] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [166.389293] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (2.108s) [166.599609] [015/133] (929s left) gem_exec_parallel (basic) [166.722859] Starting subtest: basic [166.725903] Starting dynamic subtest: rcs0 [169.808460] Dynamic subtest rcs0: SUCCESS (3.085s) [169.827808] Starting dynamic subtest: bcs0 [173.043835] Dynamic subtest bcs0: SUCCESS (3.235s) [173.062415] Starting dynamic subtest: vcs0 [176.159168] Dynamic subtest vcs0: SUCCESS (3.114s) [176.185611] Starting dynamic subtest: vecs0 [180.183682] Dynamic subtest vecs0: SUCCESS (4.027s) [180.184854] Subtest basic: SUCCESS (13.465s) [180.432509] [016/133] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [180.618120] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [180.621327] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [180.747544] [017/133] (915s left) gen9_exec_parse (batch-without-end) [180.869183] Starting subtest: batch-without-end [180.873339] Subtest batch-without-end: SUCCESS (0.003s) [181.131941] [018/133] (915s left) gem_exec_fence (long-history) [181.789856] Starting subtest: long-history [187.466067] Subtest long-history: SUCCESS (5.683s) [188.139183] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true [188.142834] [019/133] (908s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [188.258148] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [188.260074] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [188.511337] [020/133] (908s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [188.717542] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [188.723337] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.002s) [188.876503] [021/133] (907s left) gem_linear_blits (interruptible) [189.754103] Starting subtest: interruptible [204.882204] Subtest interruptible: SUCCESS (15.125s) [205.032724] [022/133] (891s left) gem_mmap_gtt (basic-wc) [205.246133] Starting subtest: basic-wc [205.874140] Subtest basic-wc: SUCCESS (0.632s) [206.055337] [023/133] (890s left) kms_addfb_basic (invalid-set-prop-any) [206.156446] Starting subtest: invalid-set-prop-any [206.157908] Subtest invalid-set-prop-any: SUCCESS (0.000s) [206.391312] [024/133] (890s left) syncobj_eventfd (timeline-wait-before-signal) [206.502740] Starting subtest: timeline-wait-before-signal [206.537060] Subtest timeline-wait-before-signal: SUCCESS (0.034s) [206.673434] [025/133] (890s left) gem_mmap_offset (oob-read) [206.774262] Starting subtest: oob-read [206.776151] Subtest oob-read: SUCCESS (0.002s) [206.928262] [026/133] (890s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling) [207.135470] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling [207.139078] Starting dynamic subtest: pipe-A-valid-mode [208.167537] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.027s) [208.168731] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SUCCESS (1.033s) [208.558293] [027/133] (888s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [208.749108] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [208.751084] Starting dynamic subtest: pipe-A-HDMI-A-1 [208.768111] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [208.808140] Starting dynamic subtest: pipe-A-HDMI-A-2 [208.839408] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [208.875123] Starting dynamic subtest: pipe-B-HDMI-A-1 [208.906409] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [208.941036] Starting dynamic subtest: pipe-B-HDMI-A-2 [208.950388] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [208.970165] Starting dynamic subtest: pipe-C-HDMI-A-1 [208.978215] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [208.998196] Starting dynamic subtest: pipe-C-HDMI-A-2 [209.006792] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [209.008365] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.023s) [209.852977] [028/133] (887s left) perf (gen12-group-exclusive-stream-ctx-handle) [210.139566] Starting subtest: gen12-group-exclusive-stream-ctx-handle [210.141738] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s) [210.244380] [029/133] (887s left) kms_plane_multiple (tiling-4) [210.426650] Starting subtest: tiling-4 [210.428569] Subtest tiling-4: SKIP (0.000s) [210.560867] [030/133] (887s left) gem_userptr_blits (sync-unmap-cycles) [210.697613] Starting subtest: sync-unmap-cycles [216.089893] Subtest sync-unmap-cycles: SUCCESS (5.393s) [216.262160] [031/133] (881s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [216.457550] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [216.459785] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [216.608194] [032/133] (881s left) gem_exec_params (invalid-bsd2-flag-on-render) [216.718646] Starting subtest: invalid-bsd2-flag-on-render [216.719668] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.001s) [216.860092] [033/133] (880s left) gem_mmap_gtt (cpuset-big-copy-odd) [216.960347] Starting subtest: cpuset-big-copy-odd [235.428093] Subtest cpuset-big-copy-odd: SUCCESS (18.460s) [235.630523] [034/133] (862s left) gem_ctx_persistence (heartbeat-many) [235.845090] Starting subtest: heartbeat-many [236.331891] Subtest heartbeat-many: SUCCESS (0.485s) [236.489229] [035/133] (861s left) kms_flip (absolute-wf_vblank) [236.684065] Starting subtest: absolute-wf_vblank [236.685101] Starting dynamic subtest: A-HDMI-A1 [242.592837] Dynamic subtest A-HDMI-A1: SUCCESS (5.904s) [242.614287] Starting dynamic subtest: B-HDMI-A1 [248.021454] Dynamic subtest B-HDMI-A1: SUCCESS (5.426s) [248.044352] Starting dynamic subtest: C-HDMI-A1 [253.416586] Dynamic subtest C-HDMI-A1: SUCCESS (5.391s) [253.439367] Starting dynamic subtest: A-HDMI-A2 [258.817499] Dynamic subtest A-HDMI-A2: SUCCESS (5.398s) [258.840332] Starting dynamic subtest: B-HDMI-A2 [264.220506] Dynamic subtest B-HDMI-A2: SUCCESS (5.399s) [264.242709] Starting dynamic subtest: C-HDMI-A2 [269.620087] Dynamic subtest C-HDMI-A2: SUCCESS (5.395s) [269.624057] Subtest absolute-wf_vblank: SUCCESS (32.934s) [270.193584] [036/133] (827s left) syncobj_timeline (wait-all-complex) [270.308090] Starting subtest: wait-all-complex [270.532100] Subtest wait-all-complex: SUCCESS (0.224s) [270.676384] [037/133] (827s left) perf_pmu (render-node-busy-idle) [270.795086] Starting subtest: render-node-busy-idle [270.797433] Starting dynamic subtest: rcs0 [271.428473] Dynamic subtest rcs0: SUCCESS (0.635s) [271.451153] Starting dynamic subtest: bcs0 [272.053384] Dynamic subtest bcs0: SUCCESS (0.625s) [272.078685] Starting dynamic subtest: vcs0 [272.680296] Dynamic subtest vcs0: SUCCESS (0.623s) [272.702966] Starting dynamic subtest: vecs0 [273.309153] Dynamic subtest vecs0: SUCCESS (0.628s) [273.310788] Subtest render-node-busy-idle: SUCCESS (2.515s) [273.446468] [038/133] (824s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [273.636792] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [273.752879] [039/133] (824s left) kms_big_fb (y-tiled-64bpp-rotate-90) [273.965071] Starting subtest: y-tiled-64bpp-rotate-90 [274.341519] Subtest y-tiled-64bpp-rotate-90: SKIP (0.372s) [274.628803] [040/133] (823s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [274.834847] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [274.839307] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [274.977589] [041/133] (823s left) kms_flip (flip-vs-blocking-wf-vblank) [275.151147] Starting subtest: flip-vs-blocking-wf-vblank [275.154114] Starting dynamic subtest: A-HDMI-A1 [281.154726] Dynamic subtest A-HDMI-A1: SUCCESS (6.002s) [281.177379] Starting dynamic subtest: B-HDMI-A1 [286.998215] Dynamic subtest B-HDMI-A1: SUCCESS (5.840s) [287.021357] Starting dynamic subtest: C-HDMI-A1 [292.854515] Dynamic subtest C-HDMI-A1: SUCCESS (5.854s) [292.879426] Starting dynamic subtest: A-HDMI-A2 [298.734856] Dynamic subtest A-HDMI-A2: SUCCESS (5.878s) [298.759535] Starting dynamic subtest: B-HDMI-A2 [304.604291] Dynamic subtest B-HDMI-A2: SUCCESS (5.868s) [304.631029] Starting dynamic subtest: C-HDMI-A2 [310.456064] Dynamic subtest C-HDMI-A2: SUCCESS (5.843s) [310.459174] Subtest flip-vs-blocking-wf-vblank: SUCCESS (35.305s) [311.023876] [042/133] (787s left) syncobj_basic (create-signaled) [311.124349] Starting subtest: create-signaled [311.125205] Subtest create-signaled: SUCCESS (0.000s) [311.262465] [043/133] (787s left) kms_plane_alpha_blend (alpha-basic) [311.440065] Starting subtest: alpha-basic [311.662289] Starting dynamic subtest: pipe-A-HDMI-A-1 [313.176256] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.770s) [313.218465] Starting dynamic subtest: pipe-C-HDMI-A-1 [313.891410] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.023s) [313.894630] Subtest alpha-basic: FAIL (2.138s) [314.184650] [044/133] (784s left) kms_cursor_crc (cursor-offscreen-512x512) [314.415194] Starting subtest: cursor-offscreen-512x512 [314.419190] Subtest cursor-offscreen-512x512: SKIP (0.004s) [314.571802] [045/133] (784s left) gem_exec_whisper (basic-normal) [314.698323] Starting subtest: basic-normal [319.140276] Subtest basic-normal: SUCCESS (4.441s) [319.407037] [046/133] (779s left) kms_psr (fbc-pr-cursor-render) [319.593403] Subtest fbc-pr-cursor-render: SKIP (0.000s) [319.694775] [047/133] (779s left) kms_frontbuffer_tracking (fbcpsr-suspend) [319.892213] Starting subtest: fbcpsr-suspend [319.895416] Subtest fbcpsr-suspend: SKIP (0.000s) [320.038164] [048/133] (779s left) syncobj_wait (invalid-reset-bad-pad) [320.144120] Starting subtest: invalid-reset-bad-pad [320.147128] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [320.288707] [049/133] (779s left) gem_exec_schedule (pi-distinct-iova) [320.546488] Starting subtest: pi-distinct-iova [320.548298] Starting dynamic subtest: rcs0 [320.601401] Dynamic subtest rcs0: SUCCESS (0.054s) [320.636601] Starting dynamic subtest: bcs0 [320.672535] Dynamic subtest bcs0: SUCCESS (0.068s) [320.704586] Starting dynamic subtest: vcs0 [320.737788] Dynamic subtest vcs0: SUCCESS (0.058s) [320.766228] Starting dynamic subtest: vecs0 [320.797029] Dynamic subtest vecs0: SUCCESS (0.054s) [320.799344] Subtest pi-distinct-iova: SUCCESS (0.253s) [321.087589] [050/133] (778s left) kms_color (invalid-degamma-lut-sizes) [321.261110] Starting subtest: invalid-degamma-lut-sizes [321.263554] Starting dynamic subtest: pipe-A [321.655247] Dynamic subtest pipe-A: SUCCESS (0.392s) [321.708090] Starting dynamic subtest: pipe-B [321.712620] Dynamic subtest pipe-B: SUCCESS (0.001s) [321.764449] Starting dynamic subtest: pipe-C [321.766248] Dynamic subtest pipe-C: SUCCESS (0.001s) [321.768147] Subtest invalid-degamma-lut-sizes: SUCCESS (0.399s) [321.941961] [051/133] (777s left) gem_pxp (create-regular-context-2) [324.588155] Starting subtest: create-regular-context-2 [324.591213] Subtest create-regular-context-2: SKIP (0.000s) [324.722985] [052/133] (774s left) gem_eio (wait-wedge-immediate) [324.854551] Starting subtest: wait-wedge-immediate [325.020491] Subtest wait-wedge-immediate: SUCCESS (0.163s) [325.293618] [053/133] (774s left) perf (non-sampling-read-error) [325.582682] Starting subtest: non-sampling-read-error [325.606725] Subtest non-sampling-read-error: SUCCESS (0.023s) [325.707667] [054/133] (774s left) i915_pm_freq_api (freq-basic-api) [325.819515] Subtest freq-basic-api: SKIP (0.000s) [325.932420] [055/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [326.126344] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [326.130265] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [326.275447] [056/133] (773s left) gem_ctx_engines (invalid-engines) [326.406121] Starting subtest: invalid-engines [326.417647] Subtest invalid-engines: SUCCESS (0.014s) [326.675687] [057/133] (773s left) syncobj_timeline (multi-wait-all-signaled) [326.775157] Starting subtest: multi-wait-all-signaled [326.781278] Subtest multi-wait-all-signaled: SUCCESS (0.002s) [326.925632] [058/133] (773s left) kms_busy (extended-pageflip-hang-oldfb) [327.149059] Starting subtest: extended-pageflip-hang-oldfb [327.149912] Starting dynamic subtest: pipe-A [327.752152] Dynamic subtest pipe-A: SUCCESS (0.601s) [327.790038] Starting dynamic subtest: pipe-C [328.193233] Dynamic subtest pipe-C: SUCCESS (0.423s) [328.195087] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.046s) [328.548542] [059/133] (771s left) kms_chamelium_hpd (common-hpd-after-suspend) [329.192097] Subtest common-hpd-after-suspend: SKIP (0.000s) [329.521767] [060/133] (770s left) syncobj_timeline (etime-single-wait-submitted) [329.633124] Starting subtest: etime-single-wait-submitted [329.736743] Subtest etime-single-wait-submitted: SUCCESS (0.103s) [329.889893] [061/133] (770s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [330.072164] Starting subtest: plane-downscale-factor-0-5-with-rotation [330.075229] Starting dynamic subtest: pipe-A [335.191908] Dynamic subtest pipe-A: SKIP (5.108s) [335.239548] Starting dynamic subtest: pipe-B [340.205226] Dynamic subtest pipe-B: SKIP (5.017s) [340.238251] Starting dynamic subtest: pipe-C [346.043627] Dynamic subtest pipe-C: SKIP (5.832s) [346.048578] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (15.968s) [346.696874] [062/133] (753s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [346.957086] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [346.971626] Starting dynamic subtest: pipe-A-valid-mode [347.623173] Dynamic subtest pipe-A-valid-mode: SKIP (0.657s) [347.625912] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.668s) [348.139439] [063/133] (752s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [348.351235] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [348.355573] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [348.494198] [064/133] (752s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [348.681826] Starting subtest: basic-busy-flip-before-cursor-varying-size [348.684763] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [348.827372] [065/133] (752s left) gem_ctx_isolation (preservation-reset) [349.066135] Starting subtest: preservation-reset [349.075306] Starting dynamic subtest: rcs0 [349.500856] Dynamic subtest rcs0: SUCCESS (0.429s) [349.531201] Starting dynamic subtest: bcs0 [350.286293] Dynamic subtest bcs0: SUCCESS (0.780s) [350.337081] Starting dynamic subtest: vcs0 [350.756350] Dynamic subtest vcs0: SUCCESS (0.466s) [350.807229] Starting dynamic subtest: vecs0 [351.164306] Dynamic subtest vecs0: SUCCESS (0.401s) [351.171882] Subtest preservation-reset: SUCCESS (2.101s) [351.370709] [066/133] (749s left) syncobj_wait (reset-during-wait-for-submit) [351.483266] Starting subtest: reset-during-wait-for-submit [351.588749] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [351.758839] [067/133] (749s left) gem_exec_whisper (basic-queues-forked-all) [351.896100] Starting subtest: basic-queues-forked-all [363.721521] Subtest basic-queues-forked-all: SUCCESS (11.824s) [363.989429] [068/133] (737s left) kms_selftest (drm_plane_helper) [364.120474] Starting subtest: drm_plane_helper [364.156056] Starting dynamic subtest: drm_test_check_plane_state [364.231766] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.077s) [364.260390] Starting dynamic subtest: drm_test_check_invalid_plane_state [364.296500] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.059s) [364.302297] Subtest drm_plane_helper: SUCCESS (0.179s) [364.471907] [069/133] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [364.702548] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [364.707899] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [364.874173] [070/133] (736s left) kms_flip (dpms-vs-vblank-race-interruptible) [365.085596] Starting subtest: dpms-vs-vblank-race-interruptible [365.092588] Starting dynamic subtest: A-HDMI-A1 [368.051242] Dynamic subtest A-HDMI-A1: SUCCESS (2.952s) [368.108535] Starting dynamic subtest: B-HDMI-A1 [370.513873] Dynamic subtest B-HDMI-A1: SUCCESS (2.455s) [370.564333] Starting dynamic subtest: C-HDMI-A1 [372.948129] Dynamic subtest C-HDMI-A1: SUCCESS (2.426s) [372.984138] Starting dynamic subtest: A-HDMI-A2 [375.389614] Dynamic subtest A-HDMI-A2: SUCCESS (2.436s) [375.434843] Starting dynamic subtest: B-HDMI-A2 [377.746644] Dynamic subtest B-HDMI-A2: SUCCESS (2.357s) [377.785103] Starting dynamic subtest: C-HDMI-A2 [380.129690] Dynamic subtest C-HDMI-A2: SUCCESS (2.377s) [380.134301] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.042s) [380.500509] [071/133] (720s left) gem_exec_balancer (full-pulse) [380.648086] Starting subtest: full-pulse [385.233852] Subtest full-pulse: SUCCESS (4.587s) [385.508345] [072/133] (716s left) kms_lease (invalid-create-leases) [385.693154] Starting subtest: invalid-create-leases [385.697526] Subtest invalid-create-leases: SUCCESS (0.010s) [385.852069] [073/133] (715s left) kms_cursor_crc (cursor-random-64x21) [386.072048] Starting subtest: cursor-random-64x21 [386.138067] Starting dynamic subtest: pipe-A-HDMI-A-1 [390.330087] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.190s) [390.474388] Starting dynamic subtest: pipe-C-HDMI-A-1 [394.393232] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.951s) [394.395236] Subtest cursor-random-64x21: SUCCESS (8.323s) [394.710406] [074/133] (707s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [394.914073] Starting subtest: cursorB-vs-flipA-legacy [406.192123] Subtest cursorB-vs-flipA-legacy: SUCCESS (11.274s) [406.536423] [075/133] (695s left) i915_pm_rpm (debugfs-read) [408.495748] Starting subtest: debugfs-read [408.721293] Subtest debugfs-read: SUCCESS (0.223s) [409.157721] [076/133] (692s left) gem_eio (create-ext) [409.289984] Starting subtest: create-ext [409.352052] Subtest create-ext: SUCCESS (0.058s) [409.597499] [077/133] (692s left) gem_render_copy_redux (flink) [409.715432] Starting subtest: flink [412.619842] Subtest flink: SUCCESS (2.904s) [412.781562] [078/133] (689s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [412.968181] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [416.834377] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.868s) [417.208481] [079/133] (685s left) prime_busy (after) [417.332140] Starting subtest: after [417.346568] Starting dynamic subtest: rcs0 [417.361574] Dynamic subtest rcs0: SUCCESS (0.012s) [417.414264] Starting dynamic subtest: bcs0 [417.415335] Dynamic subtest bcs0: SUCCESS (0.019s) [417.451099] Starting dynamic subtest: vcs0 [417.452057] Dynamic subtest vcs0: SUCCESS (0.019s) [417.475084] Starting dynamic subtest: vecs0 [417.477124] Dynamic subtest vecs0: SUCCESS (0.015s) [417.542692] Subtest after: SUCCESS (0.211s) [417.710050] [080/133] (684s left) gem_fenced_exec_thrash (no-spare-fences) [417.826285] Starting subtest: no-spare-fences [420.012148] Subtest no-spare-fences: SUCCESS (2.172s) [420.162502] [081/133] (682s left) gem_pxp (protected-raw-src-copy-not-readible) [422.811125] Starting subtest: protected-raw-src-copy-not-readible [422.813438] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [422.957496] [082/133] (679s left) syncobj_timeline (wait-for-submit-snapshot) [423.068365] Starting subtest: wait-for-submit-snapshot [423.154500] Subtest wait-for-submit-snapshot: SUCCESS (0.086s) [423.311161] [083/133] (679s left) gem_spin_batch (resubmit) [423.442445] Starting subtest: resubmit [423.444693] Starting dynamic subtest: rcs0 [423.449233] Dynamic subtest rcs0: SUCCESS (0.006s) [423.491026] Starting dynamic subtest: bcs0 [423.492402] Dynamic subtest bcs0: SUCCESS (0.007s) [423.514764] Starting dynamic subtest: vcs0 [423.516089] Dynamic subtest vcs0: SUCCESS (0.005s) [423.538362] Starting dynamic subtest: vecs0 [423.539386] Dynamic subtest vecs0: SUCCESS (0.005s) [423.540366] Subtest resubmit: SUCCESS (0.037s) [423.761374] [084/133] (678s left) kms_invalid_mode (zero-hdisplay) [423.951455] Starting subtest: zero-hdisplay [423.953070] Starting dynamic subtest: pipe-A-HDMI-A-1 [424.397158] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.446s) [424.456302] Starting dynamic subtest: pipe-A-HDMI-A-2 [424.459364] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [424.512182] Starting dynamic subtest: pipe-B-HDMI-A-1 [424.515329] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [424.564794] Starting dynamic subtest: pipe-B-HDMI-A-2 [424.565842] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [424.596099] Starting dynamic subtest: pipe-C-HDMI-A-1 [424.597231] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [424.623645] Starting dynamic subtest: pipe-C-HDMI-A-2 [424.624684] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [424.625811] Subtest zero-hdisplay: SUCCESS (0.488s) [424.740541] [085/133] (678s left) i915_selftest (mock) [426.467406] Starting subtest: mock [426.470732] Starting dynamic subtest: sanitycheck [428.268761] Dynamic subtest sanitycheck: SUCCESS (1.796s) [428.295241] Starting dynamic subtest: shmem [429.974824] Dynamic subtest shmem: SUCCESS (1.700s) [429.998322] Starting dynamic subtest: fence [439.106311] Dynamic subtest fence: SUCCESS (9.128s) [439.135295] Starting dynamic subtest: scatterlist [441.819313] Dynamic subtest scatterlist: SUCCESS (2.708s) [441.848247] Starting dynamic subtest: syncmap [445.557243] Dynamic subtest syncmap: SUCCESS (3.733s) [445.586199] Starting dynamic subtest: uncore [447.258269] Dynamic subtest uncore: SUCCESS (1.697s) [447.282736] Starting dynamic subtest: ring [448.931914] Dynamic subtest ring: SUCCESS (1.667s) [448.960211] Starting dynamic subtest: engine [450.636421] Dynamic subtest engine: SUCCESS (1.702s) [450.666237] Starting dynamic subtest: timelines [460.364398] Dynamic subtest timelines: SUCCESS (9.723s) [460.391322] Starting dynamic subtest: requests [464.334407] Dynamic subtest requests: SUCCESS (3.964s) [464.363122] Starting dynamic subtest: objects [466.180480] Dynamic subtest objects: SUCCESS (1.842s) [466.206361] Starting dynamic subtest: phys [468.034644] Dynamic subtest phys: SUCCESS (1.849s) [468.062240] Starting dynamic subtest: dmabuf [469.919395] Dynamic subtest dmabuf: SUCCESS (1.880s) [469.949241] Starting dynamic subtest: vma [490.588196] Dynamic subtest vma: SUCCESS (20.664s) [490.614609] Starting dynamic subtest: evict [494.669117] Dynamic subtest evict: SUCCESS (4.075s) [494.696300] Starting dynamic subtest: gtt [500.237277] Dynamic subtest gtt: SUCCESS (5.561s) [500.263062] Starting dynamic subtest: hugepages [502.490938] Dynamic subtest hugepages: SUCCESS (2.246s) [502.515610] Starting dynamic subtest: memory_region [510.762491] Dynamic subtest memory_region: SUCCESS (8.267s) [510.767459] Subtest mock: SUCCESS (84.292s) [510.840827] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [510.843910] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [510.847892] [086/133] (592s left) gem_softpin (invalid) [513.789892] Starting subtest: invalid [513.851151] Subtest invalid: SUCCESS (0.064s) [513.992818] [FACT gem_softpin (invalid)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [513.995726] [FACT gem_softpin (invalid)] new: kernel.kmod_is_loaded.i915: true [514.002182] [087/133] (588s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [514.125326] Starting subtest: writes-after-reads [517.704823] Subtest writes-after-reads: SUCCESS (3.582s) [517.865208] [088/133] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [518.059344] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [518.062238] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [518.213457] [089/133] (584s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [518.408079] Starting subtest: primary-4-tiled-reflect-x-180 [518.417695] Subtest primary-4-tiled-reflect-x-180: SKIP (0.005s) [518.590157] [090/133] (584s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [518.781667] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [518.895374] [091/133] (584s left) syncobj_wait (invalid-wait-bad-flags) [519.011918] Starting subtest: invalid-wait-bad-flags [519.015275] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [519.161332] [092/133] (584s left) gem_userptr_blits (userfault) [519.275285] Starting subtest: userfault [519.287171] Subtest userfault: SUCCESS (0.009s) [519.483899] [093/133] (584s left) kms_psr (pr-dpms) [519.674922] Subtest pr-dpms: SKIP (0.000s) [519.790333] [094/133] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [519.990252] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [519.996138] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [520.149244] [095/133] (583s left) kms_explicit_fence (multiplane-atomic-fence-wait) [520.361020] Starting subtest: multiplane-atomic-fence-wait [520.952556] Subtest multiplane-atomic-fence-wait: SUCCESS (0.594s) [521.499651] [096/133] (582s left) kms_frontbuffer_tracking (fbc-suspend) [521.722069] Starting subtest: fbc-suspend