[88.566791] Initializing watchdogs
[88.566974]   /dev/watchdog0
[88.606872] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605]
[88.622203] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[88.628768] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[88.634353] [001/131] (960s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[88.806210] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[88.880311] [002/131] (960s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[89.026193] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[89.097387] [003/131] (960s left) gem_ctx_persistence (engines-hang)
[89.210598] Starting subtest: engines-hang
[89.211565] Starting dynamic subtest: rcs0
[89.265543] Dynamic subtest rcs0: SUCCESS (0.054s)
[89.280539] Starting dynamic subtest: bcs0
[89.282399] Dynamic subtest bcs0: SKIP (0.006s)
[89.296335] Starting dynamic subtest: vcs0
[89.321509] Dynamic subtest vcs0: SUCCESS (0.048s)
[89.338250] Starting dynamic subtest: vecs0
[89.339282] Dynamic subtest vecs0: SUCCESS (0.016s)
[89.340159] Subtest engines-hang: SUCCESS (0.128s)
[89.448764] [004/131] (959s left) gem_exec_whisper (basic-queues-priority)
[89.566437] Starting subtest: basic-queues-priority
[95.456244] Subtest basic-queues-priority: SUCCESS (5.888s)
[95.643757] [005/131] (953s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[95.771438] Starting subtest: stress-mm-invalidate-close-overlap
[97.921882] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[98.044950] [006/131] (951s left) kms_properties (connector-properties-atomic)
[98.193780] Starting subtest: connector-properties-atomic
[98.194798] Starting dynamic subtest: pipe-None-HDMI-A-1
[98.198502] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.007s)
[98.214300] Starting dynamic subtest: pipe-None-HDMI-A-2
[98.216688] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.003s)
[98.217603] Subtest connector-properties-atomic: SUCCESS (0.013s)
[98.284194] [007/131] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[98.432473] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[98.519726] [008/131] (951s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[98.665736] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[98.755047] [009/131] (950s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[98.861727] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[99.012060] [010/131] (950s left) kms_big_fb (linear-32bpp-rotate-180)
[99.158738] Subtest linear-32bpp-rotate-180: SKIP (0.000s)
[99.231414] [011/131] (950s left) i915_drm_fdinfo (virtual-busy-all)
[99.333543] Starting subtest: virtual-busy-all
[99.334498] Subtest virtual-busy-all: SUCCESS (0.001s)
[99.407216] [012/131] (950s left) gem_mmap (bad-object)
[99.501460] Starting subtest: bad-object
[99.502367] Subtest bad-object: SUCCESS (0.000s)
[99.598201] [013/131] (950s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[99.744742] Subtest fbcpsr-suspend: SKIP (0.000s)
[99.828213] [014/131] (950s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[99.973708] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[100.054523] [015/131] (950s left) gem_exec_schedule (preempt-queue)
[100.182140] Starting subtest: preempt-queue
[100.183388] Starting dynamic subtest: rcs0
[100.513409] Dynamic subtest rcs0: SUCCESS (0.330s)
[100.532451] Starting dynamic subtest: bcs0
[100.837964] Dynamic subtest bcs0: SUCCESS (0.324s)
[100.857835] Starting dynamic subtest: vcs0
[101.150319] Dynamic subtest vcs0: SUCCESS (0.312s)
[101.169718] Starting dynamic subtest: vecs0
[101.465976] Dynamic subtest vecs0: SUCCESS (0.315s)
[101.467392] Subtest preempt-queue: SUCCESS (1.285s)
[101.814220] [016/131] (948s left) kms_lease (lease-invalid-connector)
[101.960244] Subtest lease-invalid-connector: SKIP (0.000s)
[102.032782] [017/131] (948s left) syncobj_wait (multi-wait-all-signaled)
[102.126051] Starting subtest: multi-wait-all-signaled
[102.128045] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[102.206320] [018/131] (948s left) gem_exec_reloc (basic-concurrent0)
[102.315261] Starting subtest: basic-concurrent0
[107.746770] Subtest basic-concurrent0: SUCCESS (5.432s)
[107.876520] [019/131] (942s left) perf_pmu (interrupts)
[107.978031] Starting subtest: interrupts
[109.168423] Subtest interrupts: SUCCESS (1.189s)
[109.253946] [FACT perf_pmu (interrupts)] new: kernel.kmod_is_loaded.vgem: true
[109.257321] [020/131] (941s left) gem_pxp (reject-modify-context-protection-off-2)
[111.894410] Starting subtest: reject-modify-context-protection-off-2
[111.896400] Subtest reject-modify-context-protection-off-2: SKIP (0.000s)
[111.979948] [021/131] (938s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[112.086994] Starting subtest: yf-tiled-ccs-to-y-tiled
[112.087967] Starting dynamic subtest: smem
[112.359584] Dynamic subtest smem: SUCCESS (0.272s)
[112.360525] Subtest yf-tiled-ccs-to-y-tiled: SUCCESS (0.273s)
[112.570776] [022/131] (938s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[112.725648] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[112.808412] [023/131] (938s left) kms_plane_alpha_blend (constant-alpha-min)
[112.952278] Starting subtest: constant-alpha-min
[112.953932] Subtest constant-alpha-min: SKIP (0.000s)
[113.043464] [024/131] (937s left) kms_sequence (get-busy)
[113.190578] Subtest get-busy: SKIP (0.000s)
[113.273755] [025/131] (937s left) syncobj_wait (single-wait-for-submit-signaled)
[113.369803] Starting subtest: single-wait-for-submit-signaled
[113.370842] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[113.456661] [026/131] (937s left) kms_sequence (get-idle)
[113.602809] Subtest get-idle: SKIP (0.000s)
[113.684777] [027/131] (937s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[113.828781] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[113.922648] [028/131] (937s left) kms_cursor_edge_walk (256x256-left-edge)
[114.069102] Subtest 256x256-left-edge: SKIP (0.000s)
[114.150638] [029/131] (937s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[114.305385] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[114.307146] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.001s)
[114.399548] [030/131] (937s left) kms_vblank (ts-continuation-modeset-hang)
[114.545706] Subtest ts-continuation-modeset-hang: SKIP (0.000s)
[114.627745] [031/131] (936s left) kms_flip (flip-vs-expired-vblank-interruptible)
[114.783120] Starting subtest: flip-vs-expired-vblank-interruptible
[114.787032] Subtest flip-vs-expired-vblank-interruptible: SKIP (0.002s)
[114.875641] [032/131] (936s left) kms_pm_dc (dc3co-vpb-simulation)
[116.287133] Starting subtest: dc3co-vpb-simulation
[116.288890] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[116.378505] [033/131] (935s left) kms_prop_blob (basic)
[116.472305] Starting subtest: basic
[116.473292] Subtest basic: SUCCESS (0.000s)
[116.559390] [034/131] (935s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[116.709516] Starting subtest: addfb25-x-tiled-mismatch-legacy
[116.710828] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[116.827212] [035/131] (935s left) gem_exec_balancer (busy)
[116.944290] Starting subtest: busy
[119.049410] Subtest busy: SUCCESS (2.106s)
[119.262284] [036/131] (932s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[119.419185] Subtest cursor-vs-flip-atomic-transitions-varying-size: SKIP (0.000s)
[119.497939] [037/131] (932s left) gem_ctx_shared (exec-single-timeline)
[119.611903] Starting subtest: exec-single-timeline
[119.612871] Starting dynamic subtest: rcs0
[120.673609] Dynamic subtest rcs0: SUCCESS (1.061s)
[120.695102] Starting dynamic subtest: bcs0
[121.761669] Dynamic subtest bcs0: SUCCESS (1.087s)
[121.782622] Starting dynamic subtest: vcs0
[122.849715] Dynamic subtest vcs0: SUCCESS (1.087s)
[122.870922] Starting dynamic subtest: vecs0
[123.937739] Dynamic subtest vecs0: SUCCESS (1.087s)
[123.939093] Subtest exec-single-timeline: SUCCESS (4.326s)
[124.173871] [038/131] (927s left) gen9_exec_parse (bb-start-out)
[124.290295] Starting subtest: bb-start-out
[124.292865] Subtest bb-start-out: SUCCESS (0.004s)
[124.521199] [039/131] (927s left) gem_flink_basic (basic)
[124.612513] Starting subtest: basic
[124.613464] Subtest basic: SUCCESS (0.001s)
[124.725508] [040/131] (927s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[124.870949] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[124.962924] [041/131] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[125.109267] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[125.200503] [042/131] (927s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[125.348215] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[125.433473] [043/131] (927s left) gem_exec_capture (pi)
[125.539274] Starting subtest: pi
[125.540083] Starting dynamic subtest: rcs0
[146.367449] Dynamic subtest rcs0: SUCCESS (20.829s)
[146.387335] Starting dynamic subtest: bcs0
[166.949982] Dynamic subtest bcs0: SUCCESS (20.579s)
[166.968138] Starting dynamic subtest: vcs0
[187.544127] Dynamic subtest vcs0: SUCCESS (20.596s)
[187.562626] Starting dynamic subtest: vecs0
[208.137850] Dynamic subtest vecs0: SUCCESS (20.594s)
[208.138849] Subtest pi: SUCCESS (82.601s)
[208.229462] [044/131] (844s left) kms_rotation_crc (exhaust-fences)
[208.449809] Starting subtest: exhaust-fences
[208.451539] Subtest exhaust-fences: SKIP (0.000s)
[208.534438] [045/131] (844s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[208.636908] Starting subtest: multi-wait-for-submit-unsubmitted
[208.745964] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[208.832517] [046/131] (844s left) syncobj_timeline (wait-all-interrupted)
[208.925985] Starting subtest: wait-all-interrupted
[209.034278] Subtest wait-all-interrupted: SUCCESS (0.107s)
[209.119468] [047/131] (843s left) kms_invalid_mode (bad-hsync-end)
[209.264062] Starting subtest: bad-hsync-end
[209.265782] Subtest bad-hsync-end: SKIP (0.000s)
[209.347599] [048/131] (843s left) syncobj_wait (multi-wait-all-submitted)
[209.440458] Starting subtest: multi-wait-all-submitted
[209.546097] Subtest multi-wait-all-submitted: SUCCESS (0.104s)
[209.632153] [049/131] (843s left) gem_exec_capture (userptr)
[209.739916] Starting subtest: userptr
[211.027037] Subtest userptr: SUCCESS (1.287s)
[211.142458] [050/131] (842s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[211.286879] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[211.387031] [051/131] (841s left) api_intel_bb (misplaced-blitter)
[211.481304] Starting subtest: misplaced-blitter
[211.494576] Subtest misplaced-blitter: SUCCESS (0.014s)
[211.620396] [052/131] (841s left) drm_read (short-buffer-wakeup)
[211.766637] Subtest short-buffer-wakeup: SKIP (0.000s)
[211.850330] [053/131] (841s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[211.994486] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[212.087819] [054/131] (841s left) gem_close_race (basic-process)
[212.207713] Starting subtest: basic-process
[212.300377] Subtest basic-process: SUCCESS (0.092s)
[212.515741] [055/131] (841s left) gem_exec_fence (long-history)
[213.021244] Starting subtest: long-history
[218.797921] Subtest long-history: SUCCESS (5.775s)
[219.315310] [056/131] (834s left) kms_chamelium_hpd (hdmi-hpd-storm)
[219.465855] Subtest hdmi-hpd-storm: SKIP (0.000s)
[219.551945] [057/131] (834s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[219.696209] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[219.780340] [058/131] (834s left) gem_mmap_gtt (zero-extend)
[219.872562] Starting subtest: zero-extend
[219.873413] Subtest zero-extend: SUCCESS (0.000s)
[219.982933] [059/131] (834s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[220.129290] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[220.237865] [060/131] (833s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[220.384661] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[220.479057] [061/131] (833s left) syncobj_basic (bad-fd-to-handle)
[220.568797] Starting subtest: bad-fd-to-handle
[220.569754] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[220.655801] [062/131] (833s left) core_auth (basic-auth)
[220.747814] Starting subtest: basic-auth
[220.748954] Subtest basic-auth: SUCCESS (0.001s)
[220.835509] [063/131] (833s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[220.989826] Subtest cursor-vs-flip-atomic: SKIP (0.000s)
[221.077349] [064/131] (833s left) gem_exec_schedule (semaphore-codependency)
[221.205418] Starting subtest: semaphore-codependency
[221.222601] Subtest semaphore-codependency: SUCCESS (0.017s)
[221.578783] [065/131] (832s left) i915_pm_rps (reset)
[221.686959] Starting subtest: reset
[225.252337] Subtest reset: SUCCESS (3.563s)
[225.336638] [066/131] (829s left) kms_psr (fbc-psr-cursor-plane-onoff)
[225.479932] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[225.562492] [067/131] (829s left) gem_pwrite (basic-random)
[225.656270] Starting subtest: basic-random
[231.159408] Subtest basic-random: SUCCESS (5.502s)
[231.278489] [068/131] (823s left) kms_pm_rpm (basic-pci-d3-state)
[232.776931] Starting subtest: basic-pci-d3-state
[232.967729] Subtest basic-pci-d3-state: SUCCESS (0.191s)
[233.058434] [069/131] (821s left) gem_userptr_blits (readonly-pwrite-unsync)
[233.169900] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[233.327326] [070/131] (821s left) gem_exec_suspend (basic)
[233.442958] Starting subtest: basic
[233.443915] Starting dynamic subtest: smem
[234.473224] Dynamic subtest smem: SUCCESS (1.030s)
[234.474338] Subtest basic: SUCCESS (1.030s)
[234.672834] [071/131] (820s left) gem_busy (extended)
[234.919179] Starting subtest: extended
[234.920236] Starting dynamic subtest: rcs0
[234.947236] Dynamic subtest rcs0: SUCCESS (0.027s)
[234.965711] Starting dynamic subtest: bcs0
[234.966620] Dynamic subtest bcs0: SUCCESS (0.018s)
[234.984591] Starting dynamic subtest: vcs0
[234.986959] Dynamic subtest vcs0: SUCCESS (0.015s)
[235.004788] Starting dynamic subtest: vecs0
[235.005812] Dynamic subtest vecs0: SUCCESS (0.019s)
[235.007113] Subtest extended: SUCCESS (0.080s)
[235.242900] [072/131] (819s left) gem_exec_params (cliprects-invalid)
[235.344277] Starting subtest: cliprects-invalid
[235.345229] Subtest cliprects-invalid: SUCCESS (0.001s)
[235.460795] [073/131] (819s left) gem_exec_whisper (basic-normal-all)
[235.577382] Starting subtest: basic-normal-all
[239.954079] Subtest basic-normal-all: SUCCESS (4.375s)
[240.153322] [074/131] (815s left) kms_flip (dpms-vs-vblank-race)
[240.297083] Starting subtest: dpms-vs-vblank-race
[240.298811] Subtest dpms-vs-vblank-race: SKIP (0.002s)
[240.400576] [075/131] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[240.546792] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[240.638364] [076/131] (814s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[240.782674] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[240.878237] [077/131] (814s left) kms_cursor_crc (cursor-offscreen-32x10)
[241.025999] Subtest cursor-offscreen-32x10: SKIP (0.000s)
[241.108216] [078/131] (814s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[241.252583] Subtest x-tiled-16bpp-rotate-180: SKIP (0.000s)
[241.336208] [079/131] (814s left) sw_sync (sync_merge_same)
[241.436064] Starting subtest: sync_merge_same
[241.437045] Subtest sync_merge_same: SUCCESS (0.000s)
[241.530324] [080/131] (814s left) perf (polling)
[241.732345] Starting subtest: polling
[241.733347] Starting dynamic subtest: 0-rcs0
[251.803614] Dynamic subtest 0-rcs0: SUCCESS (10.069s)
[251.804632] Subtest polling: SUCCESS (10.070s)
[251.892899] [081/131] (804s left) api_intel_allocator (gem-pool)
[251.986457] Starting subtest: gem-pool
[252.003841] Subtest gem-pool: SUCCESS (0.016s)
[252.123242] [082/131] (803s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[252.268194] Subtest modeset-transition-nonblocking-fencing: SKIP (0.000s)
[252.352319] [083/131] (803s left) gem_exec_reloc (basic-gtt)
[252.458724] Starting subtest: basic-gtt
[252.475336] Subtest basic-gtt: SUCCESS (0.017s)
[252.587812] [084/131] (803s left) kms_content_protection (dp-mst-type-0)
[252.708389] Subtest dp-mst-type-0: SKIP (0.000s)
[252.802458] [085/131] (803s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[252.898709] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[253.002399] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[253.093841] [086/131] (803s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[253.211242] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[253.314597] [087/131] (803s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[253.434915] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[253.523546] [088/131] (803s left) kms_psr2_su (page_flip-p010)
[253.615419] Subtest page_flip-P010: SKIP (0.000s)
[253.705950] [089/131] (803s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[253.824386] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[253.826590] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[253.912784] [090/131] (802s left) gem_softpin (noreloc)
[254.019884] Starting subtest: noreloc
[259.482045] Subtest noreloc: SUCCESS (5.463s)
[259.600376] [091/131] (797s left) gem_media_fill (media-fill)
[259.708514] Starting subtest: media-fill
[259.709424] Starting dynamic subtest: smem
[259.717924] Dynamic subtest smem: SUCCESS (0.010s)
[259.718955] Subtest media-fill: SUCCESS (0.011s)
[259.951828] [092/131] (797s left) kms_addfb_basic (addfb25-modifier-no-flag)
[260.073557] Starting subtest: addfb25-modifier-no-flag
[260.074513] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[260.184110] [093/131] (796s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[260.301739] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[260.399888] [094/131] (796s left) perf_pmu (busy-no-semaphores)
[260.505143] Starting subtest: busy-no-semaphores
[260.506203] Starting dynamic subtest: rcs0
[261.030106] Dynamic subtest rcs0: SUCCESS (0.526s)
[261.049445] Starting dynamic subtest: bcs0
[261.562132] Dynamic subtest bcs0: SUCCESS (0.532s)
[261.583118] Starting dynamic subtest: vcs0
[262.087978] Dynamic subtest vcs0: SUCCESS (0.525s)
[262.106743] Starting dynamic subtest: vecs0
[262.613328] Dynamic subtest vecs0: SUCCESS (0.524s)
[262.614878] Subtest busy-no-semaphores: SUCCESS (2.111s)
[262.705957] [095/131] (794s left) sysfs_preempt_timeout (timeout)
[262.807210] Starting subtest: timeout
[262.808226] Starting dynamic subtest: vecs0
[263.701345] Dynamic subtest vecs0: SUCCESS (0.892s)
[263.720373] Starting dynamic subtest: vcs0
[264.586379] Dynamic subtest vcs0: SUCCESS (0.883s)
[264.604316] Starting dynamic subtest: bcs0
[265.486287] Dynamic subtest bcs0: SUCCESS (0.899s)
[265.507869] Starting dynamic subtest: rcs0
[266.393069] Dynamic subtest rcs0: SUCCESS (0.908s)
[266.393905] Subtest timeout: SUCCESS (3.587s)
[266.480079] [096/131] (790s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[266.597916] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[266.600019] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[266.684320] [097/131] (790s left) syncobj_timeline (etime-multi-wait-all-submitted)
[266.779895] Starting subtest: etime-multi-wait-all-submitted
[266.890026] Subtest etime-multi-wait-all-submitted: SUCCESS (0.109s)
[266.979309] [098/131] (790s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[267.082123] Starting subtest: saturated-hostile-nopreempt
[267.083163] Starting dynamic subtest: rcs0
[267.834390] Dynamic subtest rcs0: SUCCESS (0.752s)
[267.857324] Starting dynamic subtest: bcs0
[268.585745] Dynamic subtest bcs0: SUCCESS (0.751s)
[268.608606] Starting dynamic subtest: vcs0
[269.339179] Dynamic subtest vcs0: SUCCESS (0.753s)
[269.358819] Starting dynamic subtest: vecs0
[270.088868] Dynamic subtest vecs0: SUCCESS (0.749s)
[270.089847] Subtest saturated-hostile-nopreempt: SUCCESS (3.007s)
[270.206847] [099/131] (787s left) kms_cursor_legacy (single-bo)
[270.326301] Starting subtest: single-bo
[270.327846] Starting dynamic subtest: pipe-A
[275.727744] Dynamic subtest pipe-A: SUCCESS (5.399s)
[275.747343] Starting dynamic subtest: pipe-B
[281.121386] Dynamic subtest pipe-B: SUCCESS (5.393s)
[281.144146] Starting dynamic subtest: pipe-C
[286.520873] Dynamic subtest pipe-C: SUCCESS (5.400s)
[286.540550] Starting dynamic subtest: all-pipes
[291.916907] Dynamic subtest all-pipes: SUCCESS (5.395s)
[291.917861] Subtest single-bo: SUCCESS (21.589s)
[292.004867] [100/131] (765s left) kms_psr (pr-sprite-plane-onoff)
[292.128111] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[292.211753] [101/131] (765s left) kms_draw_crc (draw-method-mmap-gtt)
[292.332778] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[292.422405] [102/131] (765s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[292.541295] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[292.632398] [103/131] (765s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[292.751320] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[292.833853] [104/131] (765s left) kms_plane_multiple (tiling-yf)
[292.954747] Subtest tiling-yf: SKIP (0.000s)
[293.039286] [105/131] (765s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[293.158589] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[293.244965] [106/131] (765s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[293.339990] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[293.342021] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[293.430871] [107/131] (764s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[293.549753] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[293.648504] [108/131] (764s left) kms_chamelium_color (ctm-0-75)
[293.768769] Subtest ctm-0-75: SKIP (0.000s)
[293.857489] [109/131] (764s left) i915_hangman (gt-engine-error)
[293.972650] Starting subtest: gt-engine-error
[293.973571] Starting dynamic subtest: rcs0
[294.057701] Dynamic subtest rcs0: SUCCESS (0.083s)
[294.077041] Starting dynamic subtest: bcs0
[294.078823] Dynamic subtest bcs0: SKIP (0.003s)
[294.105891] Starting dynamic subtest: vcs0
[294.160691] Dynamic subtest vcs0: SUCCESS (0.099s)
[294.179110] Starting dynamic subtest: vecs0
[294.241240] Dynamic subtest vecs0: SUCCESS (0.080s)
[294.242322] Subtest gt-engine-error: SUCCESS (0.268s)
[294.378545] [110/131] (764s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[294.497105] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[294.589815] [111/131] (764s left) gem_ctx_param (invalid-size-set)
[294.683309] Starting subtest: invalid-size-set
[294.684308] Subtest invalid-size-set: SUCCESS (0.000s)
[294.770998] [112/131] (764s left) gem_ppgtt (blt-vs-render-ctx0)
[294.873353] Starting subtest: blt-vs-render-ctx0
[327.388478] Subtest blt-vs-render-ctx0: SUCCESS (32.514s)
[327.533140] [113/131] (731s left) gem_ccs (large-ctrl-surf-copy)
[327.699806] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[327.785360] [114/131] (731s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[327.917026] Subtest cursorA-vs-flipA-legacy: SKIP (0.000s)
[327.998056] [115/131] (731s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[328.121617] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[328.214641] [116/131] (730s left) kms_writeback (writeback-fb-id-xrgb2101010)
[328.335113] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s)
[328.428669] [117/131] (730s left) kms_psr (psr-no-drrs)
[328.548236] Subtest psr-no-drrs: SKIP (0.000s)
[328.640819] [118/131] (730s left) syncobj_wait (reset-during-wait-for-submit)
[328.744962] Starting subtest: reset-during-wait-for-submit
[328.849884] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[328.939091] [119/131] (730s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[329.064516] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[329.157299] [120/131] (730s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[329.277974] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[329.279678] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (0.000s)
[329.369386] [121/131] (730s left) i915_suspend (debugfs-reader)
[329.463871] Starting subtest: debugfs-reader
[348.106058] Subtest debugfs-reader: SUCCESS (3.526s)
[354.243332] [122/131] (711s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[354.349836] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[354.351783] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[354.444068] [123/131] (711s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[354.564089] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[354.565048] Starting dynamic subtest: pipe-A
[354.566733] Dynamic subtest pipe-A: SKIP (0.000s)
[354.589271] Starting dynamic subtest: pipe-B
[354.591103] Dynamic subtest pipe-B: SKIP (0.000s)
[354.620137] Starting dynamic subtest: pipe-C
[354.623198] Dynamic subtest pipe-C: SKIP (0.000s)
[354.625609] Subtest plane-downscale-factor-0-75-with-modifiers: SKIP (0.001s)
[354.709934] [124/131] (711s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[354.805593] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[354.902266] [125/131] (711s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[355.023785] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[355.120792] [126/131] (711s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[355.243842] Subtest cursor-rapid-movement-32x10: SKIP (0.000s)
[355.336536] [127/131] (710s left) gem_spin_batch (spin-all-new)
[355.449976] Starting subtest: spin-all-new
[355.473894] Subtest spin-all-new: SUCCESS (0.022s)
[355.700814] [128/131] (710s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[355.824946] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[355.930886] [129/131] (710s left) syncobj_eventfd (binary-wait-before-signal)
[356.028776] Starting subtest: binary-wait-before-signal
[356.062778] Subtest binary-wait-before-signal: SUCCESS (0.033s)
[356.159842] [130/131] (710s left) kms_psr (fbc-psr2-primary-page-flip)
[356.280652] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[356.376546] [131/131] (710s left) syncobj_timeline (reset-during-wait-for-submit)
[356.474222] Starting subtest: reset-during-wait-for-submit
[356.579688] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[356.670962] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_frames
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: gem_ctx_persistence
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_properties
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: gem_mmap
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_lease
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_pxp
results: parsing output: 20/ for test: gem_render_copy
results: parsing output: 21/ for test: kms_psr2_sf
results: parsing output: 22/ for test: kms_plane_alpha_blend
results: parsing output: 23/ for test: kms_sequence
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_vblank
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_pm_dc
results: parsing output: 32/ for test: kms_prop_blob
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_ctx_shared
results: parsing output: 37/ for test: gen9_exec_parse
results: parsing output: 38/ for test: gem_flink_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_exec_capture
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_exec_capture
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: drm_read
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_close_race
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: kms_chamelium_hpd
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_basic
results: parsing output: 61/ for test: core_auth
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: i915_pm_rps
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_pwrite
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: gem_exec_suspend
results: parsing output: 70/ for test: gem_busy
results: parsing output: 71/ for test: gem_exec_params
results: parsing output: 72/ for test: gem_exec_whisper
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_content_protection
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_psr2_su
results: parsing output: 88/ for test: kms_flip_scaled_crc
results: parsing output: 89/ for test: gem_softpin
results: parsing output: 90/ for test: gem_media_fill
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: perf_pmu
results: parsing output: 94/ for test: sysfs_preempt_timeout
results: parsing output: 95/ for test: kms_flip_scaled_crc
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_draw_crc
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_chamelium_color
results: parsing output: 108/ for test: i915_hangman
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: gem_ppgtt
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: kms_writeback
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: syncobj_wait
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: i915_suspend
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: gem_spin_batch
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_eventfd
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
Done.