[88.140455] Initializing watchdogs [88.140634] /dev/watchdog0 [88.180185] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [88.195362] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [88.202970] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [88.209146] [001/133] (960s left) syncobj_basic (bad-flags-handle-to-fd) [88.326976] Starting subtest: bad-flags-handle-to-fd [88.330155] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [88.474992] [002/133] (960s left) i915_query (engine-info) [88.579574] Starting subtest: engine-info [88.583396] Subtest engine-info: SUCCESS (0.006s) [88.742036] [003/133] (960s left) gem_ctx_create (basic-files) [88.870730] Starting subtest: basic-files [90.903869] Subtest basic-files: SUCCESS (2.028s) [91.147252] [004/133] (957s left) kms_psr (fbc-pr-suspend) [91.343082] Subtest fbc-pr-suspend: SKIP (0.000s) [91.438884] [005/133] (957s left) vgem_basic (dmabuf-export) [91.640154] Starting subtest: dmabuf-export [91.644418] Subtest dmabuf-export: SUCCESS (0.006s) [91.786330] [FACT vgem_basic (dmabuf-export)] new: kernel.kmod_is_loaded.vgem: true [91.791662] [006/133] (957s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [92.005808] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [92.293638] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.286s) [92.558682] [007/133] (956s left) gem_ctx_isolation (nonpriv) [92.689317] Starting subtest: nonpriv [92.692882] Starting dynamic subtest: rcs0 [93.459785] Dynamic subtest rcs0: SUCCESS (0.766s) [93.477192] Starting dynamic subtest: bcs0 [94.748840] Dynamic subtest bcs0: SUCCESS (1.288s) [94.776199] Starting dynamic subtest: vcs0 [95.518348] Dynamic subtest vcs0: SUCCESS (0.767s) [95.538143] Starting dynamic subtest: vecs0 [96.300985] Dynamic subtest vecs0: SUCCESS (0.782s) [96.302995] Subtest nonpriv: SUCCESS (3.607s) [96.577178] [008/133] (952s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [96.760071] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [96.868784] [009/133] (952s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [96.979719] Starting subtest: multi-wait-for-submit-unsubmitted [97.084049] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.102s) [97.230335] [010/133] (952s left) i915_query (query-topology-unsupported) [97.333462] Starting subtest: query-topology-unsupported [97.336830] Subtest query-topology-unsupported: SKIP (0.000s) [97.480169] [011/133] (952s left) kms_flip (flip-vs-rmfb) [97.658246] Starting subtest: flip-vs-rmfb [97.663139] Starting dynamic subtest: A-HDMI-A1 [103.365040] Dynamic subtest A-HDMI-A1: SUCCESS (5.698s) [103.382987] Starting dynamic subtest: B-HDMI-A1 [108.756147] Dynamic subtest B-HDMI-A1: SUCCESS (5.383s) [108.775065] Starting dynamic subtest: C-HDMI-A1 [114.142771] Dynamic subtest C-HDMI-A1: SUCCESS (5.382s) [114.163323] Starting dynamic subtest: A-HDMI-A2 [119.565899] Dynamic subtest A-HDMI-A2: SUCCESS (5.415s) [119.585215] Starting dynamic subtest: B-HDMI-A2 [124.937504] Dynamic subtest B-HDMI-A2: SUCCESS (5.366s) [124.955976] Starting dynamic subtest: C-HDMI-A2 [130.300078] Dynamic subtest C-HDMI-A2: SUCCESS (5.356s) [130.303167] Subtest flip-vs-rmfb: SUCCESS (32.630s) [130.802255] [012/133] (918s left) gen7_exec_parse (basic-allocation) [130.922870] Subtest basic-allocation: SKIP (0.000s) [131.045569] [013/133] (918s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [131.248957] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [131.254653] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [131.388420] [014/133] (918s left) gem_basic (create-fd-close) [131.494265] Starting subtest: create-fd-close [131.498771] Subtest create-fd-close: SUCCESS (0.000s) [131.640648] [015/133] (918s left) gem_eio (throttle) [131.775211] Starting subtest: throttle [131.850077] Subtest throttle: SUCCESS (0.066s) [132.099969] [016/133] (917s left) perf (blocking-parameterized) [132.322241] Starting subtest: blocking-parameterized [152.354593] Subtest blocking-parameterized: SUCCESS (20.036s) [152.464542] [017/133] (897s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [152.682805] Starting subtest: yf-tiled-16bpp-rotate-180 [156.648158] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (3.966s) [157.009258] [018/133] (893s left) gem_ctx_shared (exec-single-timeline) [157.141219] Starting subtest: exec-single-timeline [157.143894] Starting dynamic subtest: rcs0 [158.188596] Dynamic subtest rcs0: SUCCESS (1.043s) [158.206408] Starting dynamic subtest: bcs0 [159.275160] Dynamic subtest bcs0: SUCCESS (1.085s) [159.293168] Starting dynamic subtest: vcs0 [160.361766] Dynamic subtest vcs0: SUCCESS (1.086s) [160.381250] Starting dynamic subtest: vecs0 [161.452122] Dynamic subtest vecs0: SUCCESS (1.086s) [161.454714] Subtest exec-single-timeline: SUCCESS (4.309s) [161.726828] [019/133] (888s left) kms_psr (fbc-psr-sprite-mmap-gtt) [161.918212] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [162.034483] [020/133] (888s left) kms_flip (nonexisting-fb-interruptible) [162.238060] Starting subtest: nonexisting-fb-interruptible [162.245040] Starting dynamic subtest: A-HDMI-A1 [162.908749] Dynamic subtest A-HDMI-A1: SUCCESS (0.663s) [162.947958] Starting dynamic subtest: B-HDMI-A1 [163.299298] Dynamic subtest B-HDMI-A1: SUCCESS (0.382s) [163.335085] Starting dynamic subtest: C-HDMI-A1 [163.742763] Dynamic subtest C-HDMI-A1: SUCCESS (0.438s) [163.778220] Starting dynamic subtest: A-HDMI-A2 [164.180471] Dynamic subtest A-HDMI-A2: SUCCESS (0.432s) [164.217123] Starting dynamic subtest: B-HDMI-A2 [164.617079] Dynamic subtest B-HDMI-A2: SUCCESS (0.434s) [164.654110] Starting dynamic subtest: C-HDMI-A2 [165.000072] Dynamic subtest C-HDMI-A2: SUCCESS (0.371s) [165.002124] Subtest nonexisting-fb-interruptible: SUCCESS (2.755s) [165.550453] [021/133] (885s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [165.750114] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [165.755137] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [165.898252] [022/133] (884s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [166.083076] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [166.085080] Starting dynamic subtest: pipe-A-HDMI-A-1 [166.111083] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [166.148262] Starting dynamic subtest: pipe-A-HDMI-A-2 [166.182198] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [166.215452] Starting dynamic subtest: pipe-B-HDMI-A-1 [166.245357] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [166.273734] Starting dynamic subtest: pipe-B-HDMI-A-2 [166.290051] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [166.308824] Starting dynamic subtest: pipe-C-HDMI-A-1 [166.325443] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [166.344682] Starting dynamic subtest: pipe-C-HDMI-A-2 [166.360210] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [166.363300] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.030s) [167.125328] [023/133] (883s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [167.321252] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [167.325093] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [167.456402] [024/133] (883s left) kms_setmode (basic-clone-single-crtc) [167.561072] Starting subtest: basic-clone-single-crtc [168.048557] Subtest basic-clone-single-crtc: SKIP (0.485s) [168.344858] [025/133] (882s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [168.561334] Starting subtest: fbc-1p-pri-indfb-multidraw [185.269385] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (16.705s) [185.545917] [026/133] (865s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [185.733215] Starting subtest: addfb25-x-tiled-mismatch-legacy [185.734861] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [185.905545] [027/133] (865s left) i915_module_load (reload-no-display) [186.005110] Starting subtest: reload-no-display [190.595490] Subtest reload-no-display: SUCCESS (4.590s) [190.661174] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [190.664478] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [190.669834] [028/133] (860s left) syncobj_timeline (single-wait-available-submitted) [193.490328] Starting subtest: single-wait-available-submitted [193.508110] Subtest single-wait-available-submitted: SUCCESS (0.002s) [193.696185] [FACT syncobj_timeline (single-wait-available-submitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [193.699105] [FACT syncobj_timeline (single-wait-available-submitted)] new: kernel.kmod_is_loaded.i915: true [193.716683] [029/133] (857s left) gem_exec_suspend (basic) [193.860252] Starting subtest: basic [193.865070] Starting dynamic subtest: smem [195.043843] Dynamic subtest smem: SUCCESS (1.183s) [195.045862] Subtest basic: SUCCESS (1.187s) [195.307822] [030/133] (856s left) i915_pm_rpm (gem-evict-pwrite) [197.223813] Starting subtest: gem-evict-pwrite [197.838189] Subtest gem-evict-pwrite: SUCCESS (0.612s) [198.287609] [031/133] (853s left) kms_chamelium_frames (dp-crc-multiple) [198.855076] Subtest dp-crc-multiple: SKIP (0.000s) [199.175422] [032/133] (852s left) perf (non-sampling-read-error) [199.399107] Starting subtest: non-sampling-read-error [199.417901] Subtest non-sampling-read-error: SUCCESS (0.023s) [199.533871] [033/133] (852s left) gem_exec_whisper (basic-queues-all) [199.665064] Starting subtest: basic-queues-all [208.022077] Subtest basic-queues-all: SUCCESS (8.358s) [208.283253] [034/133] (843s left) kms_flip (2x-nonexisting-fb-interruptible) [208.493098] Starting subtest: 2x-nonexisting-fb-interruptible [208.499941] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [209.321316] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (0.818s) [209.368839] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [210.136736] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (0.807s) [210.182159] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [210.885390] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (0.736s) [210.890066] Subtest 2x-nonexisting-fb-interruptible: SUCCESS (2.392s) [211.483902] [035/133] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [211.693408] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [211.699881] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [211.838112] [036/133] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [212.055081] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [214.562063] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SUCCESS (2.509s) [214.791615] [037/133] (837s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [214.986141] Starting subtest: compare-crc-sanitycheck-xr24 [214.988962] Starting dynamic subtest: pipe-A-HDMI-A-1 [215.893791] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.905s) [215.919954] Starting dynamic subtest: pipe-B-HDMI-A-2 [216.498574] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.597s) [216.532939] Starting dynamic subtest: pipe-C-HDMI-A-1 [217.106521] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.600s) [217.108710] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.125s) [217.477759] [038/133] (834s left) gen9_exec_parse (bb-start-out) [217.616354] Starting subtest: bb-start-out [217.623369] Subtest bb-start-out: SUCCESS (0.006s) [217.903778] [039/133] (834s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [218.106096] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [218.112081] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [218.261310] [040/133] (834s left) sw_sync (sync_multi_producer_single_consumer) [218.365722] Starting subtest: sync_multi_producer_single_consumer [219.449077] Subtest sync_multi_producer_single_consumer: SUCCESS (1.081s) [219.576268] [041/133] (832s left) gem_exec_balancer (full-late) [219.701106] Starting subtest: full-late [224.302932] Subtest full-late: SUCCESS (4.602s) [224.588242] [042/133] (828s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [224.697800] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [224.800427] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.105s) [224.971250] [043/133] (827s left) api_intel_allocator (reloc-allocator) [225.078123] Starting subtest: reloc-allocator [225.080315] Starting dynamic subtest: basic [225.087576] Dynamic subtest basic: SUCCESS (0.007s) [225.114146] Starting dynamic subtest: parallel-one [225.115966] Dynamic subtest parallel-one: SUCCESS (0.013s) [225.135806] Starting dynamic subtest: print [225.138140] Dynamic subtest print: SUCCESS (0.000s) [225.165477] Starting dynamic subtest: reuse [225.167306] Dynamic subtest reuse: SUCCESS (0.000s) [225.187305] Starting dynamic subtest: fork-reopen-allocator [225.189354] Dynamic subtest fork-reopen-allocator: SUCCESS (0.039s) [225.192090] Subtest reloc-allocator: SUCCESS (0.083s) [225.349489] [044/133] (827s left) kms_content_protection (atomic-dpms) [225.554924] Starting subtest: atomic-dpms [225.571170] Subtest atomic-dpms: SKIP (0.015s) [225.718711] [045/133] (827s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [227.634130] Starting subtest: modeset-lpsp-stress-no-wait [227.740888] Subtest modeset-lpsp-stress-no-wait: SKIP (0.108s) [228.143930] [046/133] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [228.341364] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [228.348109] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [228.498850] [047/133] (824s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [228.693111] Starting subtest: basic-flip-before-cursor-atomic [230.032125] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.337s) [230.364873] [048/133] (822s left) kms_big_fb (y-tiled-64bpp-rotate-0) [230.594829] Starting subtest: y-tiled-64bpp-rotate-0 [237.348386] Subtest y-tiled-64bpp-rotate-0: SUCCESS (6.756s) [237.878244] [049/133] (815s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [237.987120] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [238.103329] [050/133] (815s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [238.315788] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [238.322461] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [238.476999] [051/133] (815s left) perf (stress-open-close) [238.719338] Starting subtest: stress-open-close [238.722926] Starting dynamic subtest: 0-rcs0 [240.934752] Dynamic subtest 0-rcs0: SUCCESS (2.212s) [240.937444] Subtest stress-open-close: SUCCESS (2.215s) [241.049195] [052/133] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc) [241.260147] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc [241.266082] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.001s) [241.411116] [053/133] (812s left) fbdev (unaligned-write) [241.535629] Starting subtest: unaligned-write [241.745605] Subtest unaligned-write: SUCCESS (0.211s) [241.880455] [054/133] (811s left) perf_pmu (idle) [241.996173] Starting subtest: idle [241.998792] Starting dynamic subtest: rcs0 [242.513146] Dynamic subtest rcs0: SUCCESS (0.514s) [242.534614] Starting dynamic subtest: bcs0 [243.031495] Dynamic subtest bcs0: SUCCESS (0.517s) [243.056415] Starting dynamic subtest: vcs0 [243.546217] Dynamic subtest vcs0: SUCCESS (0.510s) [243.572117] Starting dynamic subtest: vecs0 [244.063096] Dynamic subtest vecs0: SUCCESS (0.512s) [244.066839] Subtest idle: SUCCESS (2.068s) [244.211489] [055/133] (809s left) kms_pm_backlight (basic-brightness) [244.390954] Subtest basic-brightness: SKIP (0.000s) [244.503502] [056/133] (809s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [244.699089] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [244.817616] [057/133] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [245.017894] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [245.025102] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [245.178940] [058/133] (809s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [245.381864] Starting subtest: short-busy-flip-before-cursor-toggle [245.386475] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [245.527967] [059/133] (808s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [245.750544] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [248.682322] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.930s) [248.993468] [060/133] (805s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [249.177121] Starting subtest: 2x-cursor-vs-flip-atomic [278.864377] Subtest 2x-cursor-vs-flip-atomic: SUCCESS (29.680s) [279.167102] [061/133] (775s left) gem_lmem_swapping (verify-random) [279.292291] Subtest verify-random: SKIP (0.000s) [279.406609] [062/133] (775s left) gem_tiled_wb [317.616223] [063/133] (737s left) kms_draw_crc (draw-method-mmap-wc) [317.802057] Starting subtest: draw-method-mmap-wc [317.804090] Starting dynamic subtest: xrgb8888-untiled [318.282730] Dynamic subtest xrgb8888-untiled: SUCCESS (0.482s) [318.308439] Starting dynamic subtest: rgb565-untiled [318.531157] Dynamic subtest rgb565-untiled: SUCCESS (0.245s) [318.555647] Starting dynamic subtest: xrgb2101010-untiled [318.800233] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.263s) [318.824062] Starting dynamic subtest: xbgr16161616f-untiled [319.084391] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.279s) [319.104347] Starting dynamic subtest: xrgb8888-xtiled [319.268272] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.180s) [319.289091] Starting dynamic subtest: rgb565-xtiled [319.449156] Dynamic subtest rgb565-xtiled: SUCCESS (0.178s) [319.471142] Starting dynamic subtest: xrgb2101010-xtiled [319.616754] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.162s) [319.639109] Starting dynamic subtest: xbgr16161616f-xtiled [319.782053] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.162s) [319.804582] Starting dynamic subtest: xrgb8888-ytiled [319.966292] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.180s) [319.987801] Starting dynamic subtest: rgb565-ytiled [320.149239] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s) [320.170895] Starting dynamic subtest: xrgb2101010-ytiled [320.315329] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.162s) [320.338035] Starting dynamic subtest: xbgr16161616f-ytiled [320.482961] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.163s) [320.485230] Subtest draw-method-mmap-wc: SUCCESS (2.687s) [320.714582] [064/133] (734s left) kms_color (ctm-negative) [320.892210] Starting subtest: ctm-negative [320.894083] Starting dynamic subtest: pipe-A-HDMI-A-1 [321.904124] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.006s) [321.954185] Starting dynamic subtest: pipe-A-HDMI-A-2 [322.570237] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.663s) [322.617340] Starting dynamic subtest: pipe-B-HDMI-A-1 [323.232844] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.655s) [323.271634] Starting dynamic subtest: pipe-B-HDMI-A-2 [323.919407] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.687s) [323.961521] Starting dynamic subtest: pipe-C-HDMI-A-1 [324.590715] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.668s) [324.618202] Starting dynamic subtest: pipe-C-HDMI-A-2 [325.267942] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.672s) [325.273545] Subtest ctm-negative: SUCCESS (4.376s) [325.586400] [065/133] (729s left) vgem_basic (create) [325.720186] Starting subtest: create [325.724244] Subtest create: SUCCESS (0.001s) [325.886750] [066/133] (729s left) kms_big_fb (4-tiled-8bpp-rotate-0) [326.102584] Starting subtest: 4-tiled-8bpp-rotate-0 [326.107120] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [326.256219] [067/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [326.475319] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [326.479062] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [326.637086] [068/133] (728s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [326.823053] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [326.825083] Starting dynamic subtest: pipe-A [327.156113] Dynamic subtest pipe-A: SUCCESS (0.338s) [327.183179] Starting dynamic subtest: pipe-B [327.683716] Dynamic subtest pipe-B: SUCCESS (0.523s) [327.724060] Starting dynamic subtest: pipe-C [327.768689] Dynamic subtest pipe-C: SUCCESS (0.076s) [327.771271] Subtest planes-unity-scaling-downscale-factor-0-5: SUCCESS (0.952s) [328.247902] [069/133] (727s left) kms_vblank (wait-busy-hang) [328.444206] Starting subtest: wait-busy-hang [328.446102] Starting dynamic subtest: pipe-A-HDMI-A-1 [335.874170] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.425s) [335.922241] Starting dynamic subtest: pipe-A-HDMI-A-2 [342.855066] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.972s) [342.898346] Starting dynamic subtest: pipe-C-HDMI-A-1 [349.812478] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.944s) [349.844833] Starting dynamic subtest: pipe-C-HDMI-A-2 [356.842709] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (7.019s) [356.845089] Subtest wait-busy-hang: SUCCESS (28.402s) [357.204231] [070/133] (698s left) kms_flip (flip-vs-wf_vblank-interruptible) [357.435079] Starting subtest: flip-vs-wf_vblank-interruptible [357.437476] Starting dynamic subtest: A-HDMI-A1 [359.080748] Dynamic subtest A-HDMI-A1: SUCCESS (1.641s) [359.110284] Starting dynamic subtest: B-HDMI-A1 [360.252682] Dynamic subtest B-HDMI-A1: SUCCESS (1.162s) [360.274182] Starting dynamic subtest: C-HDMI-A1 [361.411474] Dynamic subtest C-HDMI-A1: SUCCESS (1.155s) [361.436132] Starting dynamic subtest: A-HDMI-A2 [362.733954] Dynamic subtest A-HDMI-A2: SUCCESS (1.317s) [362.760342] Starting dynamic subtest: B-HDMI-A2 [363.908352] Dynamic subtest B-HDMI-A2: SUCCESS (1.170s) [363.937802] Starting dynamic subtest: C-HDMI-A2 [365.219223] Dynamic subtest C-HDMI-A2: SUCCESS (1.299s) [365.223273] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.783s) [365.763462] [071/133] (689s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [365.959722] Starting subtest: primary-4-tiled-reflect-x-180 [365.965106] Subtest primary-4-tiled-reflect-x-180: SKIP (0.003s) [366.112919] [072/133] (689s left) gem_softpin (allocator-nopin) [366.240760] Starting subtest: allocator-nopin [366.477654] Subtest allocator-nopin: SUCCESS (0.226s) [366.645224] [073/133] (689s left) kms_big_fb (linear-8bpp-rotate-0) [366.851585] Starting subtest: linear-8bpp-rotate-0 [370.845970] Subtest linear-8bpp-rotate-0: SUCCESS (3.999s) [371.131279] [074/133] (684s left) kms_atomic_interruptible (legacy-setmode) [371.324085] Starting subtest: legacy-setmode [371.332380] Starting dynamic subtest: pipe-A-HDMI-A-1 [378.135918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.807s) [378.145405] Subtest legacy-setmode: SUCCESS (6.816s) [378.459272] [075/133] (677s left) gem_exec_fence (syncobj-channel) [379.031922] Starting subtest: syncobj-channel [380.097322] Subtest syncobj-channel: SUCCESS (1.061s) [380.496400] [076/133] (675s left) i915_drm_fdinfo (virtual-busy) [380.611225] Starting subtest: virtual-busy [382.773502] Subtest virtual-busy: SUCCESS (2.163s) [382.926780] [077/133] (673s left) kms_cursor_crc (cursor-rapid-movement-64x64) [383.117079] Starting subtest: cursor-rapid-movement-64x64 [383.170088] Starting dynamic subtest: pipe-A-HDMI-A-1 [384.067825] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.900s) [384.182418] Starting dynamic subtest: pipe-C-HDMI-A-1 [384.717084] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.579s) [384.718782] Subtest cursor-rapid-movement-64x64: SUCCESS (1.605s) [385.059817] [078/133] (671s left) api_intel_bb (reset-bb) [385.173715] Starting subtest: reset-bb [385.182090] Subtest reset-bb: SUCCESS (0.009s) [385.328353] [079/133] (671s left) gem_exec_schedule (timeslicing) [385.463237] Starting subtest: timeslicing [385.464963] Starting dynamic subtest: rcs0 [385.471864] Dynamic subtest rcs0: SUCCESS (0.010s) [385.508931] Starting dynamic subtest: bcs0 [385.510655] Dynamic subtest bcs0: SUCCESS (0.008s) [385.531077] Starting dynamic subtest: vcs0 [385.533254] Dynamic subtest vcs0: SUCCESS (0.006s) [385.554380] Starting dynamic subtest: vecs0 [385.556793] Dynamic subtest vecs0: SUCCESS (0.007s) [385.559303] Subtest timeslicing: SUCCESS (0.048s) [385.914558] [080/133] (670s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [386.111355] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [386.115605] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [386.259748] [081/133] (670s left) syncobj_eventfd (timeline-wait) [386.375250] Starting subtest: timeline-wait [386.390304] Subtest timeline-wait: SUCCESS (0.012s) [386.543336] [082/133] (670s left) gem_ctx_persistence (heartbeat-close) [386.658166] Starting subtest: heartbeat-close [386.782115] Subtest heartbeat-close: SUCCESS (0.123s) [386.945233] [083/133] (669s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [387.165859] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [387.174161] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [387.363845] [084/133] (669s left) kms_addfb_basic (no-handle) [387.466968] Starting subtest: no-handle [387.468880] Subtest no-handle: SUCCESS (0.000s) [387.726330] [085/133] (669s left) syncobj_wait (single-wait-for-submit-signaled) [387.837464] Starting subtest: single-wait-for-submit-signaled [387.839254] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [387.977564] [086/133] (669s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier) [388.173171] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier [388.176774] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.000s) [388.325802] [087/133] (668s left) gem_exec_whisper (basic-fds-all) [388.461716] Starting subtest: basic-fds-all [402.321795] Subtest basic-fds-all: SUCCESS (13.861s) [402.580332] [088/133] (654s left) gem_eio (in-flight-suspend) [402.717770] Starting subtest: in-flight-suspend