[74.161225] Initializing watchdogs
[74.161404]   /dev/watchdog0
[74.186947] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[74.195926] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.199883] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.203425] [001/131] (960s left) gen9_exec_parse (bb-chained)
[74.291881] Subtest bb-chained: SKIP (0.000s)
[74.341790] [002/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[74.404665] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[74.458668] [003/131] (960s left) kms_properties (crtc-properties-atomic)
[74.755044] Starting subtest: crtc-properties-atomic
[74.757544] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.194874] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.438s)
[75.205734] Starting dynamic subtest: pipe-B-HDMI-A-1
[75.503424] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.308s)
[75.504250] Subtest crtc-properties-atomic: SUCCESS (0.749s)
[76.020570] [004/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[76.326186] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[76.327617] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.737024] [005/131] (958s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[76.791808] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[76.847129] [006/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[77.150278] Starting subtest: psr-1p-primscrn-cur-indfb-move
[77.151716] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[77.569971] [007/131] (957s left) kms_psr (psr2-primary-mmap-cpu)
[77.872261] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[78.089921] [008/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[78.395556] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[78.397313] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[78.794975] [009/131] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[79.100715] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[79.102130] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[79.479638] [010/131] (955s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[79.791228] Starting subtest: 4-tiled-addfb-size-offset-overflow
[79.792718] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[80.191285] [011/131] (954s left) gem_eio (wait-immediate)
[80.258894] Starting subtest: wait-immediate
[80.286802] Subtest wait-immediate: SUCCESS (0.028s)
[80.949185] [012/131] (954s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[81.251338] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[81.435577] [013/131] (953s left) gem_exec_alignment (many)
[81.497241] Starting subtest: many
[116.554383] Subtest many: SUCCESS (35.058s)
[119.243316] [014/131] (916s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[119.672523] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[122.262848] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.589s)
[122.722263] [015/131] (912s left) kms_psr (fbc-psr-cursor-blt)
[123.029179] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[123.216182] [016/131] (912s left) gem_fence_thrash (bo-write-verify-threaded-y)
[123.274633] Starting subtest: bo-write-verify-threaded-y
[125.224612] Subtest bo-write-verify-threaded-y: SUCCESS (1.952s)
[125.370659] [017/131] (910s left) fbdev (unaligned-read)
[125.441038] Starting subtest: unaligned-read
[125.452573] Subtest unaligned-read: SUCCESS (0.012s)
[125.566517] [018/131] (909s left) kms_lease (lease-unleased-crtc)
[125.866670] Starting subtest: lease-unleased-crtc
[125.867527] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.967944] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.102s)
[125.982237] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.000409] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.030s)
[126.001154] Subtest lease-unleased-crtc: SUCCESS (0.135s)
[126.510043] [019/131] (909s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[126.820979] Starting subtest: x-tiled-16bpp-rotate-0
[128.132210] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.310s)
[128.563933] [020/131] (907s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[128.873136] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[129.067391] [021/131] (906s left) gem_exec_balancer (bonded-false-hang)
[129.126932] Subtest bonded-false-hang: SKIP (0.000s)
[129.242677] [022/131] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[129.538497] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[129.539891] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[129.939215] [023/131] (905s left) gem_exec_params (mmapped)
[129.998853] Starting subtest: mmapped
[130.000805] Subtest mmapped: SUCCESS (0.002s)
[130.154730] [024/131] (905s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[130.452095] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[132.275649] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.824s)
[132.716759] [025/131] (903s left) gem_mmap_gtt (cpuset-big-copy)
[132.775820] Starting subtest: cpuset-big-copy
[135.646398] Subtest cpuset-big-copy: SUCCESS (2.871s)
[135.881291] [026/131] (899s left) kms_psr (fbc-psr2-sprite-blt)
[136.293194] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[136.485290] [027/131] (899s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[136.543561] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[136.621830] [028/131] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[136.923659] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[136.925274] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[137.323943] [029/131] (898s left) kms_getfb (getfb-handle-protection)
[137.625166] Starting subtest: getfb-handle-protection
[137.646925] Subtest getfb-handle-protection: SUCCESS (0.023s)
[138.060569] [030/131] (897s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[138.135398] Starting subtest: multi-wait-all-for-submit-submitted
[138.242231] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[138.356914] [031/131] (897s left) kms_flip (2x-plain-flip-ts-check)
[138.656853] Starting subtest: 2x-plain-flip-ts-check
[138.657733] Starting dynamic subtest: AB-VGA1-HDMI-A1
[169.363441] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.706s)
[169.366125] Subtest 2x-plain-flip-ts-check: SUCCESS (30.710s)
[169.983172] [032/131] (866s left) gem_pxp (reject-modify-context-protection-on)
[172.557487] Starting subtest: reject-modify-context-protection-on
[172.559491] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[172.673505] [033/131] (863s left) kms_chamelium_audio (dp-audio-edid)
[173.049430] Subtest dp-audio-edid: SKIP (0.000s)
[173.368974] [034/131] (862s left) sysfs_timeslice_duration (timeout)
[173.427537] Starting subtest: timeout
[173.428359] Starting dynamic subtest: vcs0
[173.433450] Dynamic subtest vcs0: SKIP (0.000s)
[173.447676] Starting dynamic subtest: bcs0
[173.449986] Dynamic subtest bcs0: SKIP (0.000s)
[173.465863] Starting dynamic subtest: rcs0
[173.468458] Dynamic subtest rcs0: SKIP (0.000s)
[173.470563] Subtest timeout: SKIP (0.003s)
[173.559811] [035/131] (862s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[173.617835] Starting subtest: invalid-bsd2-flag-on-vebox
[173.620272] Subtest invalid-bsd2-flag-on-vebox: SKIP (0.000s)
[173.757142] [036/131] (862s left) gem_exercise_blt (fast-copy-emit)
[173.814534] Subtest fast-copy-emit: SKIP (0.000s)
[173.879504] [037/131] (862s left) kms_plane_multiple (2x-tiling-4)
[174.175981] Starting subtest: 2x-tiling-4
[174.177870] Subtest 2x-tiling-4: SKIP (0.000s)
[174.576704] [038/131] (861s left) dmabuf_sync_file (export-before-signal)
[174.697596] Starting subtest: export-before-signal
[174.699809] Subtest export-before-signal: SUCCESS (0.003s)
[174.790350] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[174.792766] [039/131] (861s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[174.850659] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[174.906723] [040/131] (861s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[175.210428] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[175.211847] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[175.625780] [041/131] (860s left) i915_pm_rpm (gem-pread)
[187.131422] Subtest gem-pread: SKIP (0.000s)
[187.333101] [042/131] (849s left) prime_vgem (fence-wait)
[187.410993] Starting subtest: fence-wait
[187.412175] Starting dynamic subtest: rcs0
[188.435241] Dynamic subtest rcs0: SUCCESS (1.023s)
[188.456442] Starting dynamic subtest: bcs0
[189.467196] Dynamic subtest bcs0: SUCCESS (1.030s)
[189.468236] Subtest fence-wait: SUCCESS (2.056s)
[189.630451] [043/131] (847s left) syncobj_timeline (invalid-wait-bad-flags)
[189.695760] Starting subtest: invalid-wait-bad-flags
[189.696489] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[189.831654] [044/131] (846s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[190.136042] Starting subtest: fbcpsr-rgb565-draw-render
[190.138763] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[190.568456] [045/131] (846s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[190.624987] Starting subtest: wait-all-for-submit-delayed-submit
[190.727947] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[190.871145] [046/131] (845s left) gem_exec_flush (basic-wb-rw-default)
[190.938612] Starting subtest: basic-wb-rw-default
[196.383494] Subtest basic-wb-rw-default: SUCCESS (5.445s)
[196.618879] [047/131] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[196.919728] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[196.921117] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.333395] [048/131] (839s left) kms_pipe_crc_basic (suspend-read-crc)
[197.631044] Starting subtest: suspend-read-crc
[197.631918] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.307012] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.578s)
[215.319701] Starting dynamic subtest: pipe-B-HDMI-A-1
[233.299459] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.686s)
[233.300451] Subtest suspend-read-crc: SUCCESS (3.268s)
[239.830709] [049/131] (803s left) gem_exec_reloc (basic-gtt-wc)
[239.906018] Starting subtest: basic-gtt-wc
[239.911691] Subtest basic-gtt-wc: SUCCESS (0.006s)
[240.588965] [050/131] (802s left) gem_watchdog (default-physical)
[240.655225] Starting subtest: default-physical
[240.658191] Subtest default-physical: SKIP (0.002s)
[240.765994] [051/131] (802s left) gem_fence_thrash (bo-write-verify-threaded-x)
[240.820399] Starting subtest: bo-write-verify-threaded-x
[242.575253] Subtest bo-write-verify-threaded-x: SUCCESS (1.746s)
[242.731006] [052/131] (800s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[243.029096] Starting subtest: fbc-rgb565-draw-blt
[244.882122] Subtest fbc-rgb565-draw-blt: SUCCESS (1.843s)
[245.303169] [053/131] (797s left) kms_universal_plane (disable-primary-vs-flip)
[245.607300] Starting subtest: disable-primary-vs-flip
[245.608088] Starting dynamic subtest: pipe-A-HDMI-A-1
[245.980985] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.373s)
[245.997588] Starting dynamic subtest: pipe-B-HDMI-A-1
[246.388710] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.404s)
[246.389568] Subtest disable-primary-vs-flip: SUCCESS (0.781s)
[246.929172] [054/131] (796s left) kms_cursor_edge_walk (128x128-top-edge)
[247.229530] Starting subtest: 128x128-top-edge
[247.231405] Starting dynamic subtest: pipe-A-HDMI-A-1
[250.663667] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.423s)
[250.677975] Starting dynamic subtest: pipe-B-HDMI-A-1
[254.002697] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.331s)
[254.003496] Subtest 128x128-top-edge: SUCCESS (6.759s)
[254.537431] [055/131] (788s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[254.840055] Starting subtest: flip-vs-cursor-busy-crc-legacy
[255.415175] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.574s)
[255.939923] [056/131] (787s left) kms_flip (modeset-vs-vblank-race-interruptible)
[256.246064] Starting subtest: modeset-vs-vblank-race-interruptible
[256.248122] Starting dynamic subtest: A-VGA1
[259.258132] Dynamic subtest A-VGA1: SUCCESS (3.007s)
[259.273457] Starting dynamic subtest: B-VGA1
[262.256356] Dynamic subtest B-VGA1: SUCCESS (2.993s)
[262.271180] Starting dynamic subtest: A-HDMI-A1
[265.413401] Dynamic subtest A-HDMI-A1: SUCCESS (3.151s)
[265.431149] Starting dynamic subtest: B-HDMI-A1
[268.648467] Dynamic subtest B-HDMI-A1: SUCCESS (3.230s)
[268.651997] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.394s)
[269.258243] [057/131] (774s left) perf_pmu (busy-start)
[269.376806] Starting subtest: busy-start
[269.378766] Starting dynamic subtest: rcs0
[271.900426] Dynamic subtest rcs0: SUCCESS (2.523s)
[271.918714] Starting dynamic subtest: bcs0
[274.419407] Dynamic subtest bcs0: SUCCESS (2.517s)
[274.435747] Starting dynamic subtest: vcs0
[277.438402] Dynamic subtest vcs0: SUCCESS (3.017s)
[277.441651] Subtest busy-start: SUCCESS (8.065s)
[277.572746] [058/131] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[277.870587] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[277.872057] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[278.286634] [059/131] (765s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[278.347267] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[278.417129] [060/131] (765s left) kms_flip (2x-flip-vs-expired-vblank)
[278.711715] Starting subtest: 2x-flip-vs-expired-vblank
[278.712572] Starting dynamic subtest: AB-VGA1-HDMI-A1
[309.059476] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.341s)
[309.062109] Subtest 2x-flip-vs-expired-vblank: SUCCESS (30.346s)
[309.702317] [061/131] (733s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[310.000368] Starting subtest: basic-flip-before-cursor-atomic
[310.984429] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.982s)
[311.509245] [062/131] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[311.808864] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[311.810285] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[312.241657] [063/131] (731s left) gem_ctx_param (basic)
[312.298433] Starting subtest: basic
[312.299097] Subtest basic: SUCCESS (0.000s)
[312.428017] [064/131] (731s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[312.483637] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[312.555428] [065/131] (731s left) gem_create (create-ext-placement-each)
[312.726845] Starting subtest: create-ext-placement-each
[312.727625] Subtest create-ext-placement-each: SUCCESS (0.000s)
[312.856712] [066/131] (731s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[313.238742] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[313.549588] [067/131] (730s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[313.852531] Starting subtest: extended-pageflip-modeset-hang-oldfb
[313.853363] Starting dynamic subtest: pipe-A
[320.344131] Dynamic subtest pipe-A: SUCCESS (6.485s)
[320.357858] Starting dynamic subtest: pipe-B
[326.344320] Dynamic subtest pipe-B: SUCCESS (5.994s)
[326.345107] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.485s)
[326.878646] [068/131] (717s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[326.938407] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[326.939219] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[327.076384] [069/131] (717s left) api_intel_bb (add-remove-objects)
[327.134499] Starting subtest: add-remove-objects
[327.139086] Subtest add-remove-objects: SUCCESS (0.006s)
[327.297166] [070/131] (716s left) gem_exec_fence (keep-in-fence)
[327.471843] Subtest keep-in-fence: SKIP (0.000s)
[327.890471] [071/131] (716s left) api_intel_bb (destroy-bb)
[327.945309] Starting subtest: destroy-bb
[327.951632] Subtest destroy-bb: SUCCESS (0.006s)
[328.111210] [072/131] (716s left) kms_psr (fbc-pr-cursor-render)
[328.402993] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[328.601683] [073/131] (715s left) gem_softpin (safe-alignment)
[328.665670] Starting subtest: safe-alignment
[328.674839] Subtest safe-alignment: SUCCESS (0.010s)
[328.840503] [074/131] (715s left) i915_hangman (gt-engine-error)
[328.905316] Starting subtest: gt-engine-error
[328.906654] Subtest gt-engine-error: SKIP (0.000s)
[328.984229] [075/131] (715s left) kms_cursor_crc (cursor-onscreen-512x512)
[329.286918] Starting subtest: cursor-onscreen-512x512
[329.289934] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[329.705030] [076/131] (714s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[330.003649] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[330.004441] Starting dynamic subtest: pipe-A
[330.006515] Dynamic subtest pipe-A: SKIP (0.001s)
[330.023883] Starting dynamic subtest: pipe-B
[330.025723] Dynamic subtest pipe-B: SKIP (0.001s)
[330.026914] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.005s)
[330.421003] [077/131] (714s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[330.721234] Starting subtest: flip-vs-cursor-busy-crc-atomic
[331.282707] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.561s)
[331.784281] [078/131] (712s left) kms_dp_link_training (uhbr-sst)
[332.082161] Starting subtest: uhbr-sst
[332.083729] Subtest uhbr-sst: SKIP (0.000s)
[332.349463] [079/131] (712s left) perf (blocking-parameterized)
[332.556418] Subtest blocking-parameterized: SKIP (0.000s)
[332.632283] [080/131] (712s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[332.931580] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[332.933197] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[333.365501] [081/131] (711s left) vgem_basic (sysfs)
[333.431321] Starting subtest: sysfs
[333.432098] Subtest sysfs: SUCCESS (0.001s)
[333.546613] [082/131] (711s left) gem_ctx_persistence (engines-hostile)
[333.604497] Subtest engines-hostile: SKIP (0.000s)
[333.679687] [083/131] (711s left) i915_suspend (fence-restore-untiled)
[333.736709] Starting subtest: fence-restore-untiled
[351.891807] Subtest fence-restore-untiled: SUCCESS (1.700s)
[358.060534] [084/131] (692s left) syncobj_wait (invalid-reset-illegal-handle)
[358.126744] Starting subtest: invalid-reset-illegal-handle
[358.127451] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[358.258259] [085/131] (692s left) gem_readwrite (write-bad-handle)
[358.316372] Starting subtest: write-bad-handle
[358.318010] Subtest write-bad-handle: SUCCESS (0.000s)
[358.459036] [086/131] (692s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[358.515844] Starting subtest: no-spare-fences-busy
[360.684770] Subtest no-spare-fences-busy: SUCCESS (2.153s)
[360.848114] [087/131] (690s left) gem_ctx_persistence (heartbeat-close)
[360.906188] Subtest heartbeat-close: SKIP (0.000s)
[360.981356] [088/131] (690s left) kms_cursor_crc (cursor-onscreen-256x256)
[361.294262] Starting subtest: cursor-onscreen-256x256
[361.296624] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.522593] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.216s)
[363.568729] Starting dynamic subtest: pipe-B-HDMI-A-1
[365.787134] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.227s)
[365.789866] Subtest cursor-onscreen-256x256: SUCCESS (4.479s)
[366.312060] [089/131] (684s left) gem_ringfill (engines-basic)
[366.491772] Starting subtest: engines-basic
[366.494140] Starting dynamic subtest: rcs0
[366.521107] Dynamic subtest rcs0: SUCCESS (0.027s)
[366.539284] Starting dynamic subtest: bcs0
[366.540647] Dynamic subtest bcs0: SUCCESS (0.015s)
[366.541625] Subtest engines-basic: SUCCESS (0.049s)
[366.673564] [090/131] (684s left) kms_pm_rpm (cursor)
[378.175668] Subtest cursor: SKIP (0.000s)
[378.384107] [091/131] (672s left) gem_pread (bench)
[378.450347] Starting subtest: bench
[379.724674] Subtest bench: SUCCESS (1.271s)
[379.869282] [092/131] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[380.169669] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[382.043144] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.872s)
[382.479937] [093/131] (669s left) gem_exec_schedule (submit-golden-slice)
[382.561065] Subtest submit-golden-slice: SKIP (0.000s)
[382.796425] [094/131] (668s left) gem_exec_schedule (preempt-contexts)
[382.861036] Subtest preempt-contexts: SKIP (0.000s)
[383.078259] [095/131] (668s left) kms_frontbuffer_tracking (psr-suspend)
[383.375248] Starting subtest: psr-suspend
[383.376664] Subtest psr-suspend: SKIP (0.000s)
[383.797910] [096/131] (667s left) gem_exec_capture (capture-invisible)
[383.856821] Subtest capture-invisible: SKIP (0.000s)
[383.939962] [097/131] (667s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[383.993819] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[384.056514] [098/131] (667s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[384.360778] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[385.422669] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.060s)
[385.876006] [099/131] (665s left) kms_big_fb (linear-64bpp-rotate-90)
[386.184147] Starting subtest: linear-64bpp-rotate-90
[386.206736] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[386.655695] [100/131] (665s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[386.956297] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[386.959631] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[387.392140] [101/131] (664s left) kms_content_protection (dp-mst-suspend-resume)
[387.707706] Starting subtest: dp-mst-suspend-resume
[387.709068] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[388.123024] [102/131] (663s left) kms_atomic (plane-primary-legacy)
[388.426310] Starting subtest: plane-primary-legacy
[388.427104] Starting dynamic subtest: pipe-A-HDMI-A-1
[388.686118] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.258s)
[388.686903] Subtest plane-primary-legacy: SUCCESS (0.261s)
[389.215218] [103/131] (662s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[389.275272] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[389.276047] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[389.389128] [104/131] (662s left) gem_userptr_blits (unsync-unmap-after-close)
[389.450323] Subtest unsync-unmap-after-close: SKIP (0.000s)
[389.605707] [105/131] (662s left) drm_read (empty-nonblock)
[389.954982] Starting subtest: empty-nonblock
[389.956068] Subtest empty-nonblock: SUCCESS (0.000s)
[390.407048] [106/131] (661s left) gem_eio (suspend)
[390.470767] Starting subtest: suspend
[401.526110] Subtest suspend: SUCCESS (10.920s)
[409.141024] [107/131] (650s left) kms_psr (pr-primary-render)
[409.447037] Subtest pr-primary-render: SKIP (0.000s)
[409.654187] [108/131] (649s left) kms_vblank (ts-continuation-suspend)
[409.949263] Starting subtest: ts-continuation-suspend
[409.950334] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.999158] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.833s)
[427.013781] Starting dynamic subtest: pipe-B-HDMI-A-1
[443.979892] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.960s)
[443.980581] Subtest ts-continuation-suspend: SUCCESS (1.798s)
[450.490419] [109/131] (614s left) kms_flip (2x-nonexisting-fb-interruptible)
[450.806612] Starting subtest: 2x-nonexisting-fb-interruptible
[450.807340] Starting dynamic subtest: AB-VGA1-HDMI-A1
[451.149501] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.341s)
[451.152308] Subtest 2x-nonexisting-fb-interruptible: SUCCESS (0.345s)
[451.757357] [110/131] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[452.061417] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[452.062694] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[452.477366] [111/131] (613s left) kms_invalid_mode (uint-max-clock)
[452.775545] Starting subtest: uint-max-clock
[452.776450] Starting dynamic subtest: pipe-A-HDMI-A-1
[452.853589] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.075s)
[452.871871] Starting dynamic subtest: pipe-B-HDMI-A-1
[452.873209] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[452.874372] Subtest uint-max-clock: SUCCESS (0.080s)
[453.249583] [112/131] (612s left) kms_properties (get_properties-sanity-non-atomic)
[453.550331] Starting subtest: get_properties-sanity-non-atomic
[453.551505] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[453.960966] [113/131] (611s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[465.460989] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.000s)
[465.671110] [114/131] (600s left) kms_flip (flip-vs-absolute-wf_vblank)
[465.974305] Starting subtest: flip-vs-absolute-wf_vblank
[465.977322] Starting dynamic subtest: A-VGA1
[474.039856] Dynamic subtest A-VGA1: SUCCESS (8.047s)
[474.056947] Starting dynamic subtest: B-VGA1
[482.059010] Dynamic subtest B-VGA1: SUCCESS (8.007s)
[482.075583] Starting dynamic subtest: A-HDMI-A1
[490.256159] Dynamic subtest A-HDMI-A1: SUCCESS (8.189s)
[490.274158] Starting dynamic subtest: B-HDMI-A1
[498.474138] Dynamic subtest B-HDMI-A1: SUCCESS (8.216s)
[498.478057] Subtest flip-vs-absolute-wf_vblank: SUCCESS (32.472s)
[499.081113] [115/131] (566s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[499.159565] Starting subtest: basic-batch-kernel-default-cmd
[499.161375] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[499.396765] [116/131] (566s left) gem_exec_whisper (basic-fds-all)
[499.463466] Starting subtest: basic-fds-all
[501.390434] Subtest basic-fds-all: SUCCESS (1.926s)
[501.627061] [117/131] (564s left) kms_properties (invalid-properties-atomic)
[501.928355] Starting subtest: invalid-properties-atomic
[501.964611] Subtest invalid-properties-atomic: SUCCESS (0.038s)
[502.361068] [118/131] (563s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[502.658357] Starting subtest: plane-scaler-unity-scaling-with-rotation
[502.659140] Starting dynamic subtest: pipe-A
[502.661579] Dynamic subtest pipe-A: SKIP (0.001s)
[502.679185] Starting dynamic subtest: pipe-B
[502.681558] Dynamic subtest pipe-B: SKIP (0.001s)
[502.682925] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.005s)
[503.083377] [119/131] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[503.143412] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[503.246578] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[503.375210] [120/131] (562s left) syncobj_basic (bad-pad-handle-to-fd)
[503.435630] Starting subtest: bad-pad-handle-to-fd
[503.436320] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[503.555263] [121/131] (562s left) kms_chamelium_hpd (dp-hpd)
[503.919350] Subtest dp-hpd: SKIP (0.000s)
[504.241306] [122/131] (561s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[504.536583] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[504.681560] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[506.826313] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.144s)
[506.984712] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[509.072614] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.101s)
[509.073736] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (4.538s)
[509.724103] [123/131] (556s left) i915_drm_fdinfo (most-busy-check-all)
[509.787595] Subtest most-busy-check-all: SKIP (0.000s)
[509.849806] [124/131] (556s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[510.144616] Starting subtest: fb-8bpc-vs-panel-6bpc
[510.145544] Starting dynamic subtest: pipe-A-HDMI-A-1
[510.217035] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.070s)
[510.218574] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.073s)
[510.738092] [125/131] (555s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[511.040042] Starting subtest: cursorB-vs-flipA-atomic-transitions
[511.041779] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[511.458105] [126/131] (554s left) gem_set_tiling_vs_pwrite
[511.668389] [127/131] (554s left) gem_mmap (bad-object)
[511.728298] Starting subtest: bad-object
[511.729147] Subtest bad-object: SUCCESS (0.000s)
[511.869101] [128/131] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[512.171304] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[512.172570] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[512.587632] [129/131] (553s left) syncobj_wait (multi-wait-for-submit-submitted)
[512.647762] Starting subtest: multi-wait-for-submit-submitted
[512.757565] Subtest multi-wait-for-submit-submitted: SUCCESS (0.109s)
[512.887010] [130/131] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[513.187132] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[513.188578] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[513.601212] [131/131] (553s left) gem_mmap_offset (isolation)
[513.661030] Starting subtest: isolation
[513.668537] Subtest isolation: SUCCESS (0.007s)
[513.816840] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_exec_alignment
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exercise_blt
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: i915_suspend
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
Done.