[47.458444] Initializing watchdogs
[47.458497]   /dev/watchdog0
[47.473695] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[47.479735] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[47.482174] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[47.484396] [001/155] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[47.581236] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[47.582619] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[47.673873] [002/155] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[47.763189] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[47.764573] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[47.860048] [003/155] (960s left) gem_ctx_param (invalid-set-ringsize)
[47.892631] Starting subtest: invalid-set-ringsize
[47.893350] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[47.953678] [004/155] (960s left) kms_pm_rpm (pc8-residency)
[49.366121] Starting subtest: pc8-residency
[49.368489] Subtest pc8-residency: SKIP (0.000s)
[49.546310] [005/155] (958s left) i915_hangman (engine-engine-error)
[49.596365] Starting subtest: engine-engine-error
[49.597088] Starting dynamic subtest: rcs0
[49.668054] Dynamic subtest rcs0: SUCCESS (0.073s)
[49.681984] Starting dynamic subtest: bcs0
[49.744253] Dynamic subtest bcs0: SUCCESS (0.078s)
[49.757677] Starting dynamic subtest: vcs0
[49.815766] Dynamic subtest vcs0: SUCCESS (0.073s)
[49.830640] Starting dynamic subtest: vcs1
[49.896125] Dynamic subtest vcs1: SUCCESS (0.082s)
[49.913022] Starting dynamic subtest: vecs0
[49.978906] Dynamic subtest vecs0: SUCCESS (0.084s)
[49.980315] Subtest engine-engine-error: SUCCESS (0.394s)
[50.058788] [006/155] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[50.149357] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[50.150702] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[50.245587] [007/155] (957s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[50.335270] Starting subtest: fbchdr-tiling-y
[50.336581] Subtest fbchdr-tiling-y: SKIP (0.000s)
[50.441425] [008/155] (957s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[50.479987] Starting subtest: y-tiled-to-vebox-x-tiled
[50.480771] Starting dynamic subtest: smem
[50.572851] Dynamic subtest smem: SUCCESS (0.095s)
[50.573553] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.096s)
[50.758975] [009/155] (957s left) gem_mmap_gtt (fault-concurrent-x)
[50.792936] Starting subtest: fault-concurrent-X
[53.533102] Subtest fault-concurrent-X: SUCCESS (2.765s)
[53.626875] [010/155] (954s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt)
[53.720366] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt
[53.721793] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[53.805647] [011/155] (954s left) gem_flink_race (flink_close)
[53.836389] Starting subtest: flink_close
[58.879474] Subtest flink_close: SUCCESS (5.103s)
[58.980745] [012/155] (949s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[59.074345] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[59.075813] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[59.177517] [013/155] (949s left) gem_unref_active_buffers
[59.359792] [014/155] (949s left) kms_pm_rpm (cursor-dpms)
[60.749653] Starting subtest: cursor-dpms
[72.791197] Subtest cursor-dpms: SUCCESS (12.074s)
[72.976790] [015/155] (935s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-render)
[73.078244] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-render
[73.079611] Subtest hdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[73.190533] [016/155] (935s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[73.290198] Starting subtest: yf-tiled-64bpp-rotate-0
[73.291656] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[73.384552] [017/155] (935s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[73.478300] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[73.479737] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[73.571268] [018/155] (935s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt)
[73.663163] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt
[73.664536] Subtest fbcpsrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[73.759733] [019/155] (934s left) gem_mmap_gtt (basic-write)
[73.792447] Starting subtest: basic-write
[73.927864] Subtest basic-write: SUCCESS (0.127s)
[74.019029] [020/155] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[74.112468] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[74.113869] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[74.200630] [021/155] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[74.293177] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[74.294528] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[74.374131] [022/155] (934s left) gem_busy (semaphore)
[74.556676] Starting subtest: semaphore
[74.557698] Starting dynamic subtest: rcs0
[74.595558] Dynamic subtest rcs0: SUCCESS (0.049s)
[74.612668] Starting dynamic subtest: bcs0
[74.620131] Dynamic subtest bcs0: SUCCESS (0.024s)
[74.630185] Starting dynamic subtest: vcs0
[74.639130] Dynamic subtest vcs0: SUCCESS (0.019s)
[74.649982] Starting dynamic subtest: vcs1
[74.666610] Dynamic subtest vcs1: SUCCESS (0.027s)
[74.680937] Starting dynamic subtest: vecs0
[74.693560] Dynamic subtest vecs0: SUCCESS (0.026s)
[74.694800] Subtest semaphore: SUCCESS (0.148s)
[74.933081] [023/155] (933s left) kms_cursor_crc (cursor-offscreen-128x128)
[75.023216] Starting subtest: cursor-offscreen-128x128
[75.037114] Starting dynamic subtest: pipe-A-HDMI-A-1
[76.281667] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.246s)
[76.318334] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.532670] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.223s)
[77.533446] Subtest cursor-offscreen-128x128: SUCCESS (2.512s)
[77.671879] [024/155] (931s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[77.763866] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[77.764642] Starting dynamic subtest: pipe-A-HDMI-A-1
[77.771690] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[77.780752] Starting dynamic subtest: pipe-B-HDMI-A-1
[77.802799] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[77.809273] Starting dynamic subtest: pipe-C-HDMI-A-1
[77.815832] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[77.822181] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.829111] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[77.830605] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[78.015108] [025/155] (930s left) gem_spin_batch (resubmit)
[78.058530] Starting subtest: resubmit
[78.059240] Starting dynamic subtest: rcs0
[78.061703] Dynamic subtest rcs0: SUCCESS (0.003s)
[78.069123] Starting dynamic subtest: bcs0
[78.069850] Dynamic subtest bcs0: SUCCESS (0.002s)
[78.076363] Starting dynamic subtest: vcs0
[78.077122] Dynamic subtest vcs0: SUCCESS (0.002s)
[78.083267] Starting dynamic subtest: vcs1
[78.083978] Dynamic subtest vcs1: SUCCESS (0.002s)
[78.090474] Starting dynamic subtest: vecs0
[78.091186] Dynamic subtest vecs0: SUCCESS (0.002s)
[78.091875] Subtest resubmit: SUCCESS (0.011s)
[78.249797] [026/155] (930s left) syncobj_wait (single-wait-signaled)
[78.283641] Starting subtest: single-wait-signaled
[78.284359] Subtest single-wait-signaled: SUCCESS (0.000s)
[78.364371] [027/155] (930s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[78.455136] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[78.456476] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[78.549270] [028/155] (930s left) kms_chamelium_audio (hdmi-audio-edid)
[78.688223] Subtest hdmi-audio-edid: SKIP (0.000s)
[78.786220] [029/155] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[78.885141] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[78.886495] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[78.982314] [030/155] (930s left) kms_content_protection (mei-interface)
[79.073188] Starting subtest: mei-interface
[79.079236] Subtest mei-interface: SKIP (0.004s)
[79.181716] [031/155] (930s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[79.215123] Starting subtest: single-wait-for-submit-available-signaled
[79.215901] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[79.281915] [032/155] (929s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[79.369341] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[79.370068] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.544722] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.394s)
[96.552585] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.526272] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.386s)
[113.535393] Starting dynamic subtest: pipe-C-HDMI-A-1
[130.540040] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.366s)
[130.547288] Starting dynamic subtest: pipe-D-HDMI-A-1
[147.528541] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.400s)
[147.529264] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.550s)
[155.740383] [033/155] (861s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[155.827122] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[155.827808] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.834470] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[155.841581] Starting dynamic subtest: pipe-B-HDMI-A-1
[155.848296] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[155.855340] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.862110] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[155.869009] Starting dynamic subtest: pipe-D-HDMI-A-1
[155.875712] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[155.877073] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[156.071288] [034/155] (861s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-move)
[156.161423] Starting subtest: psrhdr-2p-primscrn-cur-indfb-move
[156.162714] Subtest psrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[156.246898] [035/155] (861s left) syncobj_wait (invalid-signal-bad-pad)
[156.279489] Starting subtest: invalid-signal-bad-pad
[156.280192] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[156.333569] [036/155] (861s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[156.426750] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[156.428049] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[156.521890] [037/155] (860s left) kms_flip (flip-vs-blocking-wf-vblank)
[156.606653] Starting subtest: flip-vs-blocking-wf-vblank
[156.609039] Starting dynamic subtest: A-HDMI-A1
[175.292915] Dynamic subtest A-HDMI-A1: SUCCESS (18.982s)
[175.309655] Starting dynamic subtest: B-HDMI-A1
[183.206125] Dynamic subtest B-HDMI-A1: SUCCESS (7.904s)
[183.212983] Starting dynamic subtest: C-HDMI-A1
[190.981892] Dynamic subtest C-HDMI-A1: SUCCESS (7.799s)
[190.989513] Starting dynamic subtest: D-HDMI-A1
[198.808712] Dynamic subtest D-HDMI-A1: SUCCESS (7.799s)
[198.809490] Subtest flip-vs-blocking-wf-vblank: SUCCESS (42.498s)
[198.936764] [038/155] (818s left) perf_pmu (init-sema)
[198.976768] Starting subtest: init-sema
[198.977519] Starting dynamic subtest: rcs0
[198.979162] Dynamic subtest rcs0: SUCCESS (0.001s)
[198.986818] Starting dynamic subtest: bcs0
[198.987520] Dynamic subtest bcs0: SUCCESS (0.000s)
[198.994816] Starting dynamic subtest: vcs0
[198.995512] Dynamic subtest vcs0: SUCCESS (0.000s)
[199.002733] Starting dynamic subtest: vcs1
[199.003428] Dynamic subtest vcs1: SUCCESS (0.001s)
[199.010598] Starting dynamic subtest: vecs0
[199.011318] Dynamic subtest vecs0: SUCCESS (0.000s)
[199.012044] Subtest init-sema: SUCCESS (0.006s)
[199.041918] [039/155] (818s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[199.135884] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[199.137324] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[199.236753] [040/155] (818s left) kms_getfb (getfb2-accept-nv12)
[199.324137] Starting subtest: getfb2-accept-nv12
[199.325706] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[199.416393] [041/155] (818s left) gem_eio (in-flight-contexts-10ms)
[199.460497] Starting subtest: in-flight-contexts-10ms
[213.496033] Subtest in-flight-contexts-10ms: SUCCESS (14.036s)
[213.620201] [042/155] (803s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[213.714650] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[213.716048] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.822508] [043/155] (803s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[213.913682] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[215.242641] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.329s)
[215.373266] [044/155] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[215.469810] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[215.471237] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[215.552736] [045/155] (802s left) gem_ctx_shared (q-smoketest-all)
[215.596494] Starting subtest: Q-smoketest-all
[247.866465] Subtest Q-smoketest-all: SUCCESS (32.265s)
[248.035794] [046/155] (769s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[248.138459] Starting subtest: 4-tiled-8bpp-rotate-180
[248.139811] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[248.219690] [047/155] (769s left) kms_vblank (wait-forked-hang)
[248.307624] Starting subtest: wait-forked-hang
[248.309511] Starting dynamic subtest: pipe-A-HDMI-A-1
[262.429034] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.115s)
[262.440838] Starting dynamic subtest: pipe-D-HDMI-A-1
[276.250673] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.816s)
[276.251419] Subtest wait-forked-hang: SUCCESS (27.937s)
[276.429985] [048/155] (741s left) dumb_buffer (invalid-bpp)
[276.467523] Starting subtest: invalid-bpp
[276.468267] Subtest invalid-bpp: SUCCESS (0.000s)
[276.545192] [049/155] (741s left) kms_psr (fbc-psr2-cursor-plane-move)
[276.637665] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[276.680958] [050/155] (741s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[276.774373] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[276.775719] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[276.869455] [051/155] (741s left) kms_flip (2x-modeset-vs-vblank-race)
[276.957878] Starting subtest: 2x-modeset-vs-vblank-race
[276.966728] Subtest 2x-modeset-vs-vblank-race: SKIP (0.009s)
[277.026998] [052/155] (740s left) drm_read (empty-nonblock)
[277.135904] Starting subtest: empty-nonblock
[277.136676] Subtest empty-nonblock: SUCCESS (0.000s)
[277.249482] [053/155] (740s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[277.338992] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[277.381359] [054/155] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[277.474720] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[277.476092] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[277.582217] [055/155] (740s left) kms_atomic_transition (plane-all-transition)
[277.670182] Starting subtest: plane-all-transition
[277.671793] Starting dynamic subtest: pipe-A-HDMI-A-1
[279.611087] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.939s)
[279.687986] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.754432] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.074s)
[281.808620] Subtest plane-all-transition: SUCCESS (4.138s)
[281.949837] [056/155] (736s left) kms_pwrite_crc (basic)
[282.053445] Starting subtest: basic
[282.359092] Subtest basic: SUCCESS (0.306s)
[282.517395] [057/155] (735s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[282.615797] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[282.617183] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[282.710574] [058/155] (735s left) gem_exec_flush (basic-wb-set-default)
[282.753183] Starting subtest: basic-wb-set-default
[288.180554] Subtest basic-wb-set-default: SUCCESS (5.428s)
[288.396073] [059/155] (729s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[288.488569] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[288.489305] Starting dynamic subtest: pipe-A
[288.882955] Dynamic subtest pipe-A: SUCCESS (0.395s)
[288.896977] Starting dynamic subtest: pipe-B
[289.325278] Dynamic subtest pipe-B: SUCCESS (0.441s)
[289.336764] Starting dynamic subtest: pipe-C
[289.778190] Dynamic subtest pipe-C: SUCCESS (0.452s)
[289.787416] Starting dynamic subtest: pipe-D
[290.228212] Dynamic subtest pipe-D: SUCCESS (0.449s)
[290.229014] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (1.741s)
[290.422470] [060/155] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[290.520873] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[290.522270] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[290.616552] [061/155] (727s left) i915_suspend (fence-restore-untiled)
[290.649479] Starting subtest: fence-restore-untiled
[311.374786] Subtest fence-restore-untiled: SUCCESS (5.127s)
[315.519345] [062/155] (706s left) gem_mmap_offset (isolation)
[315.574459] Starting subtest: isolation
[315.581206] Subtest isolation: SUCCESS (0.005s)
[315.660137] [063/155] (706s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[315.693527] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[315.694204] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[315.766090] [064/155] (706s left) i915_pm_rpm (debugfs-forcewake-user)
[317.162218] Starting subtest: debugfs-forcewake-user
[328.593864] Subtest debugfs-forcewake-user: SUCCESS (11.666s)
[328.766949] [065/155] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[328.860805] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[328.862263] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[328.934394] [066/155] (693s left) kms_cursor_legacy (single-move)
[329.022486] Starting subtest: single-move
[329.023197] Starting dynamic subtest: pipe-A
[334.404536] Dynamic subtest pipe-A: SUCCESS (5.380s)
[334.412239] Starting dynamic subtest: pipe-B
[339.766717] Dynamic subtest pipe-B: SUCCESS (5.378s)
[339.774539] Starting dynamic subtest: pipe-C
[345.136358] Dynamic subtest pipe-C: SUCCESS (5.378s)
[345.144001] Starting dynamic subtest: pipe-D
[350.512697] Dynamic subtest pipe-D: SUCCESS (5.378s)
[350.520504] Starting dynamic subtest: all-pipes
[355.896694] Dynamic subtest all-pipes: SUCCESS (5.379s)
[355.897425] Subtest single-move: SUCCESS (26.898s)
[355.930476] [067/155] (666s left) perf (polling)
[356.022493] Starting subtest: polling
[356.023191] Starting dynamic subtest: 0-rcs0
[366.082030] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[366.082955] Subtest polling: SUCCESS (10.024s)
[366.144969] [068/155] (656s left) gem_partial_pwrite_pread (write)
[366.191180] Starting subtest: write
[376.492802] Subtest write: SUCCESS (10.303s)
[376.620081] [069/155] (646s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[376.715111] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[376.716591] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[376.820239] [070/155] (645s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[376.924844] Starting subtest: extended-modeset-hang-newfb-with-reset
[376.925602] Starting dynamic subtest: pipe-A
[390.816621] Dynamic subtest pipe-A: SUCCESS (13.894s)
[390.830055] Starting dynamic subtest: pipe-D
[403.614878] Dynamic subtest pipe-D: SUCCESS (12.797s)
[403.615650] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (26.698s)
[403.767737] [071/155] (619s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[403.867111] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[403.868565] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[403.955039] [072/155] (618s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[404.048845] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[405.235550] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.188s)
[405.350687] [073/155] (617s left) kms_draw_crc (draw-method-mmap-cpu)
[405.443633] Starting subtest: draw-method-mmap-cpu
[405.444439] Starting dynamic subtest: xrgb8888-untiled
[405.593339] Dynamic subtest xrgb8888-untiled: SUCCESS (0.150s)
[405.607153] Starting dynamic subtest: rgb565-untiled
[405.743489] Dynamic subtest rgb565-untiled: SUCCESS (0.148s)
[405.761387] Starting dynamic subtest: xrgb2101010-untiled
[405.884822] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[405.902662] Starting dynamic subtest: xbgr16161616f-untiled
[406.035556] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.148s)
[406.053438] Starting dynamic subtest: xrgb8888-xtiled
[406.126966] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[406.143942] Starting dynamic subtest: rgb565-xtiled
[406.218337] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[406.236872] Starting dynamic subtest: xrgb2101010-xtiled
[406.301474] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.080s)
[406.318201] Starting dynamic subtest: xbgr16161616f-xtiled
[406.384839] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.080s)
[406.401780] Starting dynamic subtest: xrgb8888-ytiled
[406.478768] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s)
[406.493952] Starting dynamic subtest: rgb565-ytiled
[406.568261] Dynamic subtest rgb565-ytiled: SUCCESS (0.087s)
[406.586534] Starting dynamic subtest: xrgb2101010-ytiled
[406.651522] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[406.667648] Starting dynamic subtest: xbgr16161616f-ytiled
[406.734725] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[406.737657] Subtest draw-method-mmap-cpu: SUCCESS (1.294s)
[406.827650] [074/155] (616s left) kms_big_fb (linear-32bpp-rotate-0)
[406.927475] Starting subtest: linear-32bpp-rotate-0
[408.510029] Subtest linear-32bpp-rotate-0: SUCCESS (1.582s)
[408.639675] [075/155] (614s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[408.740195] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[409.409905] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.670s)
[409.547928] [076/155] (613s left) kms_atomic (plane-invalid-params-fence)
[409.637422] Starting subtest: plane-invalid-params-fence
[409.638137] Starting dynamic subtest: pipe-A-HDMI-A-1
[409.760079] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.122s)
[409.760843] Subtest plane-invalid-params-fence: SUCCESS (0.124s)
[409.921056] [077/155] (613s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[410.010332] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[410.012126] Starting dynamic subtest: pipe-A-valid-mode
[411.064329] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.053s)
[411.065126] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (1.055s)
[411.218749] [078/155] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[411.314698] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[411.316133] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[411.417208] [079/155] (611s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[411.508560] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[411.509980] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[411.618473] [080/155] (611s left) api_intel_bb (full-batch)
[411.652390] Starting subtest: full-batch
[411.655331] Subtest full-batch: SUCCESS (0.003s)
[411.777964] [081/155] (611s left) syncobj_basic (bad-pad-handle-to-fd)
[411.812406] Starting subtest: bad-pad-handle-to-fd
[411.813146] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[411.888549] [082/155] (611s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[411.926297] Starting subtest: invalid-bsd2-flag-on-blt
[411.927095] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[412.013266] [083/155] (611s left) kms_cursor_edge_walk (64x64-top-edge)
[412.101433] Starting subtest: 64x64-top-edge
[412.103204] Starting dynamic subtest: pipe-A-HDMI-A-1
[413.859436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.757s)
[413.869164] Starting dynamic subtest: pipe-D-HDMI-A-1
[415.524121] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.660s)
[415.524857] Subtest 64x64-top-edge: SUCCESS (3.421s)
[415.637590] [084/155] (607s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[415.730468] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[415.731845] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[415.787091] [085/155] (607s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[415.878811] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[415.880275] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[415.972768] [086/155] (607s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[416.060390] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[416.061768] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[416.136153] [087/155] (607s left) gem_exec_fence (nb-await)
[416.301990] Starting subtest: nb-await
[416.311696] Starting dynamic subtest: rcs0
[416.366175] Dynamic subtest rcs0: SUCCESS (0.063s)
[416.383609] Starting dynamic subtest: bcs0
[416.433847] Dynamic subtest bcs0: SUCCESS (0.065s)
[416.452069] Starting dynamic subtest: vcs0
[416.500539] Dynamic subtest vcs0: SUCCESS (0.064s)
[416.519204] Starting dynamic subtest: vcs1
[416.567225] Dynamic subtest vcs1: SUCCESS (0.064s)
[416.586865] Starting dynamic subtest: vecs0
[416.635034] Dynamic subtest vecs0: SUCCESS (0.065s)
[416.638112] Subtest nb-await: SUCCESS (0.334s)
[417.149115] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[417.151805] [088/155] (606s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[417.245133] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[417.246500] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[417.346522] [089/155] (606s left) i915_drm_fdinfo (memory-info-resident)
[417.383703] Starting subtest: memory-info-resident
[417.384492] Starting dynamic subtest: smem0
[418.655489] Dynamic subtest smem0: SUCCESS (1.270s)
[418.657086] Subtest memory-info-resident: SUCCESS (1.273s)
[418.722590] [090/155] (604s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[418.818524] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[420.106046] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.288s)
[420.255126] [091/155] (603s left) kms_properties (colorop-properties-atomic)
[420.346775] Starting subtest: colorop-properties-atomic
[420.347572] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.431857] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.085s)
[420.442230] Starting dynamic subtest: pipe-B-HDMI-A-1
[420.562777] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.129s)
[420.573390] Starting dynamic subtest: pipe-C-HDMI-A-1
[420.701413] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.136s)
[420.713762] Starting dynamic subtest: pipe-D-HDMI-A-1
[420.829991] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.125s)
[420.830735] Subtest colorop-properties-atomic: SUCCESS (0.483s)
[420.970706] [092/155] (602s left) gen9_exec_parse (bb-large)
[421.011391] Subtest bb-large: SKIP (0.000s)
[421.061029] [093/155] (602s left) kms_lease (lease-get)
[421.152585] Starting subtest: lease-get
[421.153288] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.153983] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[421.164262] Starting dynamic subtest: pipe-B-HDMI-A-1
[421.165019] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[421.173778] Starting dynamic subtest: pipe-C-HDMI-A-1
[421.174501] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[421.183072] Starting dynamic subtest: pipe-D-HDMI-A-1
[421.183785] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[421.184471] Subtest lease-get: SUCCESS (0.010s)
[421.239325] [094/155] (602s left) syncobj_eventfd (timeline-wait)
[421.274754] Starting subtest: timeline-wait
[421.285708] Subtest timeline-wait: SUCCESS (0.011s)
[421.347701] [095/155] (602s left) core_auth (many-magics)
[421.381252] Starting subtest: many-magics
[421.907218] Subtest many-magics: SUCCESS (0.526s)
[422.011916] [096/155] (601s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[422.100476] Starting subtest: flip-vs-cursor-varying-size
[430.713383] Subtest flip-vs-cursor-varying-size: SUCCESS (8.610s)
[430.869756] [097/155] (593s left) gem_mmap_wc (invalid-flags)
[430.907579] Starting subtest: invalid-flags
[430.908328] Subtest invalid-flags: SUCCESS (0.000s)
[431.000029] [098/155] (592s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[431.090840] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[431.091606] Starting dynamic subtest: pipe-A-HDMI-A-1
[431.109792] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[431.118160] Starting dynamic subtest: pipe-B-HDMI-A-1
[431.135415] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[431.143711] Starting dynamic subtest: pipe-C-HDMI-A-1
[431.160676] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[431.169242] Starting dynamic subtest: pipe-D-HDMI-A-1
[431.187876] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[431.189247] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.015s)
[431.354556] [099/155] (592s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[431.389441] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[431.391276] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[431.469370] [100/155] (592s left) kms_psr (psr2-cursor-mmap-cpu)
[431.557053] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[431.598948] [101/155] (592s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[431.691216] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[431.692738] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[431.790242] [102/155] (592s left) kms_psr (psr2-sprite-mmap-gtt)
[431.877940] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s)
[431.924629] [103/155] (592s left) gem_exec_balancer (hog)
[431.965445] Starting subtest: hog
[433.346334] Subtest hog: SUCCESS (1.372s)
[433.529665] [104/155] (590s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[433.625853] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[433.627257] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[433.733205] [105/155] (590s left) gem_ctx_engines (invalid-engines)
[433.775641] Starting subtest: invalid-engines
[433.780876] Subtest invalid-engines: SUCCESS (0.005s)
[433.977241] [106/155] (590s left) syncobj_timeline (etime-multi-wait-submitted)
[434.011355] Starting subtest: etime-multi-wait-submitted
[434.114996] Subtest etime-multi-wait-submitted: SUCCESS (0.103s)
[434.190754] [107/155] (590s left) gem_exec_parallel (userptr)
[434.231980] Starting subtest: userptr
[434.232714] Starting dynamic subtest: rcs0
[435.931650] Dynamic subtest rcs0: SUCCESS (1.699s)
[435.947759] Starting dynamic subtest: bcs0
[437.602846] Dynamic subtest bcs0: SUCCESS (1.669s)
[437.613519] Starting dynamic subtest: vcs0
[439.289854] Dynamic subtest vcs0: SUCCESS (1.686s)
[439.299640] Starting dynamic subtest: vcs1
[440.968306] Dynamic subtest vcs1: SUCCESS (1.677s)
[440.978344] Starting dynamic subtest: vecs0
[442.654082] Dynamic subtest vecs0: SUCCESS (1.684s)
[442.654996] Subtest userptr: SUCCESS (8.422s)
[442.843841] [108/155] (581s left) kms_chamelium_hpd (hdmi-hpd-fast)
[442.988662] Subtest hdmi-hpd-fast: SKIP (0.000s)
[443.094821] [109/155] (581s left) gem_exec_fence (basic-busy)
[443.266478] Starting subtest: basic-busy
[443.267495] Starting dynamic subtest: rcs0
[443.306811] Dynamic subtest rcs0: SUCCESS (0.041s)
[443.326337] Starting dynamic subtest: bcs0
[443.345991] Dynamic subtest bcs0: SUCCESS (0.037s)
[443.362659] Starting dynamic subtest: vcs0
[443.383966] Dynamic subtest vcs0: SUCCESS (0.035s)
[443.404926] Starting dynamic subtest: vcs1
[443.417868] Dynamic subtest vcs1: SUCCESS (0.031s)
[443.433263] Starting dynamic subtest: vecs0
[443.453045] Dynamic subtest vecs0: SUCCESS (0.033s)
[443.454404] Subtest basic-busy: SUCCESS (0.190s)
[443.960269] [110/155] (580s left) gem_mmap_gtt (basic-small-bo)
[443.996543] Starting subtest: basic-small-bo
[444.480707] Subtest basic-small-bo: SUCCESS (0.484s)
[444.593294] [111/155] (579s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[444.748385] Starting subtest: cursor-rapid-movement-128x128
[444.753334] Starting dynamic subtest: pipe-A-HDMI-A-1
[445.015326] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.261s)
[445.052932] Starting dynamic subtest: pipe-D-HDMI-A-1
[445.259856] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.214s)
[445.261643] Subtest cursor-rapid-movement-128x128: SUCCESS (0.511s)
[445.439313] [112/155] (579s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[445.534590] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[446.807877] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.273s)
[446.932248] [113/155] (577s left) gem_exec_schedule (u-semaphore-codependency)
[446.990907] Starting subtest: u-semaphore-codependency
[446.998864] Subtest u-semaphore-codependency: SUCCESS (0.008s)
[447.310905] [114/155] (577s left) gem_exec_reloc (basic-wc-gtt)
[447.349590] Starting subtest: basic-wc-gtt
[447.355639] Subtest basic-wc-gtt: SUCCESS (0.006s)
[447.476646] [115/155] (577s left) gem_exec_reloc (basic-write-gtt)
[447.514826] Starting subtest: basic-write-gtt
[447.520652] Subtest basic-write-gtt: SUCCESS (0.006s)
[447.644903] [116/155] (577s left) gem_pxp (create-regular-context-2)
[447.750987] Starting subtest: create-regular-context-2
[447.751953] Subtest create-regular-context-2: SUCCESS (0.001s)
[447.826286] [117/155] (576s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[447.918731] Starting subtest: hdr-2p-pri-indfb-multidraw
[447.920093] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[448.013224] [118/155] (576s left) kms_joiner (invalid-modeset-ultra-joiner)
[448.103696] Starting subtest: invalid-modeset-ultra-joiner
[448.105104] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[448.169015] [119/155] (576s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[448.261905] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[448.263312] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[448.366773] [120/155] (576s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[448.458559] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[448.460033] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[448.564840] [121/155] (576s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[448.660151] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[448.668855] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[448.728859] [122/155] (576s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[448.823085] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[448.824517] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[448.909666] [123/155] (576s left) perf (per-context-mode-unprivileged)
[449.000729] Starting subtest: per-context-mode-unprivileged
[449.002168] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[449.044219] [124/155] (575s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-4)
[449.136869] Starting subtest: fbcpsrhdr-tiling-4
[449.138254] Subtest fbcpsrhdr-tiling-4: SKIP (0.000s)
[449.241461] [125/155] (575s left) syncobj_timeline (multi-wait-all-available-signaled)
[449.283491] Starting subtest: multi-wait-all-available-signaled
[449.284194] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[449.356364] [126/155] (575s left) api_intel_allocator (gem-pool)
[449.391266] Starting subtest: gem-pool
[449.396353] Subtest gem-pool: SUCCESS (0.006s)
[449.510322] [127/155] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[449.602797] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[449.604158] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[449.693749] [128/155] (575s left) gem_exec_whisper (basic-normal-all)
[449.737843] Starting subtest: basic-normal-all
[450.885186] Subtest basic-normal-all: SUCCESS (1.147s)
[451.086136] [129/155] (574s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[451.177786] Starting subtest: addfb25-yf-tiled-legacy
[451.178600] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[451.279242] [130/155] (574s left) gem_readwrite (read-write)
[451.314067] Starting subtest: read-write
[451.316775] Subtest read-write: SUCCESS (0.000s)
[451.404920] [131/155] (573s left) gem_exec_create (madvise)
[451.445910] Starting subtest: madvise
[451.446644] Starting dynamic subtest: smem
[471.606578] Dynamic subtest smem: SUCCESS (20.162s)
[471.608664] Subtest madvise: SUCCESS (20.163s)
[472.976080] [132/155] (552s left) perf_pmu (busy-idle-no-semaphores)
[473.013593] Starting subtest: busy-idle-no-semaphores
[473.014336] Starting dynamic subtest: rcs0
[473.659609] Dynamic subtest rcs0: SUCCESS (0.637s)
[473.672537] Starting dynamic subtest: bcs0
[474.286044] Dynamic subtest bcs0: SUCCESS (0.624s)
[474.298484] Starting dynamic subtest: vcs0
[474.914256] Dynamic subtest vcs0: SUCCESS (0.626s)
[474.927507] Starting dynamic subtest: vcs1
[475.539607] Dynamic subtest vcs1: SUCCESS (0.622s)
[475.552704] Starting dynamic subtest: vecs0
[476.162017] Dynamic subtest vecs0: SUCCESS (0.620s)
[476.164201] Subtest busy-idle-no-semaphores: SUCCESS (3.141s)
[476.251074] [133/155] (549s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[476.352292] Starting subtest: y-tiled-16bpp-rotate-180
[477.535217] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.183s)
[477.666088] [134/155] (547s left) kms_color (invalid-gamma-lut-sizes)
[477.756820] Starting subtest: invalid-gamma-lut-sizes
[477.757583] Starting dynamic subtest: pipe-A
[477.810281] Dynamic subtest pipe-A: SUCCESS (0.053s)
[477.821459] Starting dynamic subtest: pipe-B
[477.822181] Dynamic subtest pipe-B: SUCCESS (0.003s)
[477.831851] Starting dynamic subtest: pipe-C
[477.832561] Dynamic subtest pipe-C: SUCCESS (0.001s)
[477.842098] Starting dynamic subtest: pipe-D
[477.842792] Dynamic subtest pipe-D: SUCCESS (0.001s)
[477.843494] Subtest invalid-gamma-lut-sizes: SUCCESS (0.063s)
[477.942558] [135/155] (547s left) kms_plane_cursor (viewport)
[478.041366] Starting subtest: viewport
[478.042740] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[479.436545] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.394s)
[479.488232] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[480.895082] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.424s)
[480.945748] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[482.320007] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.391s)
[482.412762] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[483.842043] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.439s)
[483.882054] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[485.258989] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.392s)
[485.297175] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[486.659078] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.375s)
[486.745890] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[488.175277] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.440s)
[488.212705] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[489.599807] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.400s)
[489.636070] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[491.024791] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.400s)
[491.106061] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[492.580456] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.487s)
[492.616413] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[494.005278] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.400s)
[494.045804] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[495.446922] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.417s)
[495.522454] Subtest viewport: SUCCESS (17.484s)
[495.642536] [136/155] (529s left) kms_chamelium_edid (dp-edid-resolution-list)
[495.795888] Subtest dp-edid-resolution-list: SKIP (0.000s)
[495.904294] [137/155] (529s left) kms_addfb_basic (unused-pitches)
[495.943864] Starting subtest: unused-pitches
[495.944660] Subtest unused-pitches: SUCCESS (0.000s)
[496.105230] [138/155] (529s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[496.193812] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[496.238715] [139/155] (529s left) gem_exec_reloc (basic-wc-cpu-active)
[496.276635] Starting subtest: basic-wc-cpu-active
[496.403941] Subtest basic-wc-cpu-active: SUCCESS (0.120s)
[496.525163] [140/155] (529s left) gem_render_copy (yf-tiled)
[496.566343] Starting subtest: yf-tiled
[496.567127] Starting dynamic subtest: smem
[496.634576] Dynamic subtest smem: SUCCESS (0.069s)
[496.635302] Subtest yf-tiled: SUCCESS (0.070s)
[496.831862] [141/155] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[496.923862] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[496.925287] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[497.038911] [142/155] (528s left) gem_lmem_swapping (basic)
[497.076849] Subtest basic: SKIP (0.000s)
[497.122244] [143/155] (528s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[497.212565] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[497.213317] Starting dynamic subtest: pipe-A
[498.329363] Dynamic subtest pipe-A: SUCCESS (1.117s)
[498.348351] Starting dynamic subtest: pipe-B
[499.520791] Dynamic subtest pipe-B: SUCCESS (1.190s)
[499.531571] Starting dynamic subtest: pipe-C
[499.731318] Dynamic subtest pipe-C: SUCCESS (0.210s)
[499.742452] Starting dynamic subtest: pipe-D
[499.943143] Dynamic subtest pipe-D: SUCCESS (0.211s)
[499.943845] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (2.732s)
[500.148337] [144/155] (525s left) kms_addfb_basic (clobberred-modifier)
[500.183977] Starting subtest: clobberred-modifier
[500.184686] Subtest clobberred-modifier: SUCCESS (0.000s)
[500.334389] [145/155] (525s left) perf (invalid-remove-userspace-config)
[500.417104] Starting subtest: invalid-remove-userspace-config
[500.428555] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[500.472871] [146/155] (525s left) kms_psr (fbc-psr-primary-mmap-cpu)
[500.561192] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[500.603095] [147/155] (525s left) gem_ctx_shared (detached-shared-gtt)
[500.645358] Starting subtest: detached-shared-gtt
[502.803109] Subtest detached-shared-gtt: SUCCESS (2.150s)
[502.978422] [148/155] (523s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[503.068436] Starting subtest: primary-x-tiled-reflect-x-0
[506.642467] Subtest primary-x-tiled-reflect-x-0: SUCCESS (3.574s)
[506.839196] [149/155] (519s left) prime_busy (after)
[506.879065] Starting subtest: after
[506.883912] Starting dynamic subtest: rcs0
[506.909772] Dynamic subtest rcs0: SUCCESS (0.026s)
[506.923936] Starting dynamic subtest: bcs0
[506.927466] Dynamic subtest bcs0: SUCCESS (0.017s)
[506.939222] Starting dynamic subtest: vcs0
[506.947227] Dynamic subtest vcs0: SUCCESS (0.019s)
[506.958383] Starting dynamic subtest: vcs1
[506.960384] Dynamic subtest vcs1: SUCCESS (0.012s)
[506.971712] Starting dynamic subtest: vecs0
[506.979260] Dynamic subtest vecs0: SUCCESS (0.018s)
[507.097033] Subtest after: SUCCESS (0.209s)
[507.175809] [150/155] (518s left) kms_flip (flip-vs-suspend-interruptible)
[507.269669] Starting subtest: flip-vs-suspend-interruptible
[507.271595] Starting dynamic subtest: A-HDMI-A1
[652.444439] Dynamic subtest A-HDMI-A1: SUCCESS (11.001s)
[652.446696] Subtest flip-vs-suspend-interruptible: SUCCESS (11.004s)
[661.591454] [151/155] (373s left) kms_universal_plane (universal-plane-pageflip-windowed)
[661.700710] Starting subtest: universal-plane-pageflip-windowed
[661.701433] Starting dynamic subtest: pipe-A-HDMI-A-1
[661.936957] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.246s)
[661.947685] Starting dynamic subtest: pipe-B-HDMI-A-1
[662.153901] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.225s)
[662.164895] Starting dynamic subtest: pipe-C-HDMI-A-1
[662.374933] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.229s)
[662.385640] Starting dynamic subtest: pipe-D-HDMI-A-1
[662.579762] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.212s)
[662.580443] Subtest universal-plane-pageflip-windowed: SUCCESS (0.920s)
[662.703486] [152/155] (372s left) gem_watchdog (default-physical)
[662.747825] Starting subtest: default-physical
[664.015585] Subtest default-physical: SUCCESS (1.307s)
[664.098764] [153/155] (371s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[664.193471] Starting subtest: x-tiled-addfb-size-offset-overflow
[664.194225] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[664.295422] [154/155] (371s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[664.385359] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[664.386716] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[664.474608] [155/155] (370s left) gem_exec_schedule (preempt-other-chain)
[664.519092] Starting subtest: preempt-other-chain
[664.519831] Starting dynamic subtest: rcs0
[664.557428] Dynamic subtest rcs0: SUCCESS (0.039s)
[664.567332] Starting dynamic subtest: bcs0
[664.596129] Dynamic subtest bcs0: SUCCESS (0.039s)
[664.606248] Starting dynamic subtest: vcs0
[664.635790] Dynamic subtest vcs0: SUCCESS (0.040s)
[664.647898] Starting dynamic subtest: vcs1
[664.675689] Dynamic subtest vcs1: SUCCESS (0.040s)
[664.687129] Starting dynamic subtest: vecs0
[664.715947] Dynamic subtest vecs0: SUCCESS (0.040s)
[664.716775] Subtest preempt-other-chain: SUCCESS (0.204s)
[665.012798] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: i915_hangman
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_render_copy
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_flink_race
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_unref_active_buffers
results: parsing output: 13/ for test: kms_pm_rpm
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_big_fb
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_mmap_gtt
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_spin_batch
results: parsing output: 25/ for test: syncobj_wait
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_audio
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_content_protection
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_getfb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_ctx_shared
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_vblank
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: drm_read
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_atomic_transition
results: parsing output: 55/ for test: kms_pwrite_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_flush
results: parsing output: 58/ for test: kms_plane_scaling
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: i915_suspend
results: parsing output: 61/ for test: gem_mmap_offset
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_partial_pwrite_pread
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_draw_crc
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: syncobj_basic
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_properties
results: parsing output: 91/ for test: gen9_exec_parse
results: parsing output: 92/ for test: kms_lease
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: core_auth
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_ctx_engines
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_parallel
results: parsing output: 107/ for test: kms_chamelium_hpd
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: gem_exec_reloc
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: gem_pxp
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_joiner
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: api_intel_allocator
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: gem_readwrite
results: parsing output: 130/ for test: gem_exec_create
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: kms_color
results: parsing output: 134/ for test: kms_plane_cursor
results: parsing output: 135/ for test: kms_chamelium_edid
results: parsing output: 136/ for test: kms_addfb_basic
results: parsing output: 137/ for test: kms_psr2_sf
results: parsing output: 138/ for test: gem_exec_reloc
results: parsing output: 139/ for test: gem_render_copy
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_lmem_swapping
results: parsing output: 142/ for test: kms_plane_scaling
results: parsing output: 143/ for test: kms_addfb_basic
results: parsing output: 144/ for test: perf
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: gem_ctx_shared
results: parsing output: 147/ for test: kms_rotation_crc
results: parsing output: 148/ for test: prime_busy
results: parsing output: 149/ for test: kms_flip
results: parsing output: 150/ for test: kms_universal_plane
results: parsing output: 151/ for test: gem_watchdog
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: gem_exec_schedule
Done.