[72.926092] Initializing watchdogs
[72.926233]   /dev/watchdog0
[72.946894] [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)
[72.954836] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.959185] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.965957] [001/133] (960s left) kms_chamelium_edid (dp-edid-resolution-list)
[73.610419] Subtest dp-edid-resolution-list: SKIP (0.000s)
[73.816647] [002/133] (959s left) syncobj_timeline (multi-wait-all-available-submitted)
[73.887743] Starting subtest: multi-wait-all-available-submitted
[73.889470] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s)
[73.985735] [003/133] (959s left) gen9_exec_parse (bb-chained)
[74.052185] Subtest bb-chained: SKIP (0.000s)
[74.110648] [004/133] (959s left) gem_pipe_control_store_loop (fresh-buffer)
[74.178730] Starting subtest: fresh-buffer
[76.329214] Subtest fresh-buffer: SUCCESS (2.150s)
[76.453508] [005/133] (957s left) kms_psr (psr2-suspend)
[76.936648] Subtest psr2-suspend: SKIP (0.000s)
[76.986513] [006/133] (956s left) i915_pm_rpm (gem-mmap-type)
[88.814851] Subtest gem-mmap-type: SKIP (0.000s)
[88.869476] [007/133] (944s left) kms_lease (invalid-create-leases)
[89.373054] Starting subtest: invalid-create-leases
[89.378753] Subtest invalid-create-leases: SUCCESS (0.005s)
[89.466450] [008/133] (944s left) device_reset (unbind-cold-reset-rebind)
[89.539550] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[89.596117] [009/133] (944s left) gem_mmap_offset (blt-coherency)
[89.661831] Starting subtest: blt-coherency
[89.666678] Subtest blt-coherency: SUCCESS (0.005s)
[89.789684] [010/133] (944s left) kms_cursor_crc (cursor-onscreen-512x170)
[90.278179] Starting subtest: cursor-onscreen-512x170
[90.281982] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[90.376699] [011/133] (943s left) kms_color (legacy-gamma)
[90.859057] Starting subtest: legacy-gamma
[90.861172] Starting dynamic subtest: pipe-A-VGA-1
[91.376117] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.516s)
[91.385975] Starting dynamic subtest: pipe-A-HDMI-A-1
[91.896749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.520s)
[91.908700] Starting dynamic subtest: pipe-B-VGA-1
[92.288604] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.391s)
[92.300381] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.800905] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.513s)
[92.802916] Subtest legacy-gamma: SUCCESS (1.942s)
[93.078037] [012/133] (940s left) i915_drm_fdinfo (busy-idle-check-all)
[93.145704] Subtest busy-idle-check-all: SKIP (0.000s)
[93.203708] [013/133] (940s left) gem_softpin (noreloc-interruptible)
[93.266902] Starting subtest: noreloc-interruptible
[98.660237] Subtest noreloc-interruptible: SUCCESS (5.393s)
[98.791887] [014/133] (935s left) sysfs_preempt_timeout (idempotent)
[98.865046] Starting subtest: idempotent
[98.866812] Starting dynamic subtest: vcs0
[98.870087] Dynamic subtest vcs0: SKIP (0.000s)
[98.882750] Starting dynamic subtest: bcs0
[98.886624] Dynamic subtest bcs0: SKIP (0.000s)
[98.898598] Starting dynamic subtest: rcs0
[98.902709] Dynamic subtest rcs0: SKIP (0.000s)
[98.906581] Subtest idempotent: SKIP (0.002s)
[98.973056] [015/133] (935s left) prime_busy (after)
[99.034010] Starting subtest: after
[99.039609] Starting dynamic subtest: rcs0
[99.052221] Dynamic subtest rcs0: SUCCESS (0.013s)
[99.063176] Starting dynamic subtest: bcs0
[99.072874] Dynamic subtest bcs0: SUCCESS (0.020s)
[99.084796] Starting dynamic subtest: vcs0
[99.088903] Dynamic subtest vcs0: SUCCESS (0.014s)
[99.195939] Subtest after: SUCCESS (0.161s)
[99.286955] [016/133] (934s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[99.349847] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[99.351441] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[99.444058] [017/133] (934s left) kms_pm_backlight (fade-with-suspend)
[99.924263] Subtest fade-with-suspend: SKIP (0.000s)
[99.986913] [018/133] (934s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[100.047739] Starting subtest: single-wait-all-for-submit-available-signaled
[100.049456] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[100.142513] [019/133] (934s left) kms_psr (pr-sprite-plane-move)
[100.625588] Subtest pr-sprite-plane-move: SKIP (0.000s)
[100.669989] [020/133] (933s left) kms_addfb_basic (unused-handle)
[100.734373] Starting subtest: unused-handle
[100.736035] Subtest unused-handle: SUCCESS (0.000s)
[101.257998] [021/133] (933s left) gem_mmap_gtt (cpuset-big-copy-odd)
[101.322802] Starting subtest: cpuset-big-copy-odd
[105.103265] Subtest cpuset-big-copy-odd: SUCCESS (3.782s)
[105.309365] [022/133] (929s left) kms_plane_cursor (overlay)
[105.872265] Starting subtest: overlay
[105.877188] Starting dynamic subtest: pipe-A-VGA-1-size-64
[108.657311] Dynamic subtest pipe-A-VGA-1-size-64: SUCCESS (2.784s)
[108.716590] Starting dynamic subtest: pipe-A-VGA-1-size-128
[111.415569] Dynamic subtest pipe-A-VGA-1-size-128: SUCCESS (2.708s)
[111.476633] Starting dynamic subtest: pipe-A-VGA-1-size-256
[114.173631] Dynamic subtest pipe-A-VGA-1-size-256: SUCCESS (2.708s)
[114.273703] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[117.055658] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.792s)
[117.114509] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[119.817026] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.711s)
[119.878332] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[122.577791] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.711s)
[122.709334] Subtest overlay: SUCCESS (16.839s)
[122.946751] [023/133] (911s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[123.015248] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[123.075512] [024/133] (911s left) kms_atomic (plane-immutable-zpos)
[123.552827] Starting subtest: plane-immutable-zpos
[123.554732] Starting dynamic subtest: pipe-A-VGA-1
[123.941654] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.386s)
[123.943820] Subtest plane-immutable-zpos: SUCCESS (0.387s)
[124.200673] [025/133] (910s left) gem_userptr_blits (dmabuf-sync)
[124.280917] Starting subtest: dmabuf-sync
[124.288963] Subtest dmabuf-sync: SKIP (0.005s)
[124.441529] [026/133] (910s left) kms_vrr (seamless-rr-switch-vrr)
[124.914104] Starting subtest: seamless-rr-switch-vrr
[124.922137] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[124.994228] [027/133] (909s left) gem_ctx_persistence (many-contexts)
[125.064828] Subtest many-contexts: SKIP (0.000s)
[125.122914] [028/133] (909s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[125.607651] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[127.576556] Subtest fbc-2p-primscrn-indfb-plflip-blt: SUCCESS (1.970s)
[127.721930] [029/133] (907s left) kms_psr (fbc-psr-no-drrs)
[128.201872] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[128.249808] [030/133] (906s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[128.732886] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[128.795261] [031/133] (906s left) syncobj_eventfd (invalid-bad-pad)
[128.866963] Starting subtest: invalid-bad-pad
[128.868921] Subtest invalid-bad-pad: SUCCESS (0.000s)
[128.955531] [032/133] (906s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[131.532247] Starting subtest: protected-encrypted-src-copy-not-readible
[131.535862] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s)
[131.615242] [033/133] (903s left) api_intel_allocator (fork-simple-once)
[131.678779] Starting subtest: fork-simple-once
[131.703415] Subtest fork-simple-once: SUCCESS (0.026s)
[131.817086] [034/133] (903s left) gem_pxp (create-valid-protected-context)
[134.396719] Starting subtest: create-valid-protected-context
[134.400745] Subtest create-valid-protected-context: SKIP (0.000s)
[134.493404] [035/133] (900s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[134.973165] Starting subtest: 2x-flip-vs-cursor-legacy
[135.397666] Subtest 2x-flip-vs-cursor-legacy: SUCCESS (0.422s)
[135.656427] [036/133] (899s left) perf_pmu (invalid-init)
[135.719973] Starting subtest: invalid-init
[135.721880] Subtest invalid-init: SUCCESS (0.000s)
[135.817907] [037/133] (899s left) kms_pm_rpm (pm-tiling)
[147.598347] Subtest pm-tiling: SKIP (0.000s)
[147.655631] [038/133] (887s left) gem_mmap_wc (copy)
[147.718495] Starting subtest: copy
[147.909776] Subtest copy: SUCCESS (0.189s)
[148.000503] [039/133] (887s left) gem_partial_pwrite_pread (reads-snoop)
[148.068115] Starting subtest: reads-snoop
[149.211971] Subtest reads-snoop: SUCCESS (1.143s)
[149.336981] [040/133] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[149.833737] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[151.835893] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.003s)
[152.066714] [041/133] (883s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[152.560989] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[152.565230] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[152.664324] [042/133] (882s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[153.137037] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[153.141134] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[153.235345] [043/133] (882s left) gem_vm_create (isolation)
[153.300695] Subtest isolation: SKIP (0.000s)
[153.363315] [044/133] (882s left) i915_suspend (forcewake)
[153.422067] Starting subtest: forcewake
[187.559849] Subtest forcewake: SUCCESS (1.365s)
[194.726764] [045/133] (847s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[195.218240] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[195.283506] [046/133] (847s left) gem_exec_gttfill (multigpu-basic)
[195.476616] Starting subtest: multigpu-basic
[199.568064] Subtest multigpu-basic: SUCCESS (3.990s)
[199.647079] [047/133] (843s left) kms_universal_plane (cursor-fb-leak)
[200.201322] Starting subtest: cursor-fb-leak
[200.203945] Starting dynamic subtest: pipe-A-VGA-1
[200.479767] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.275s)
[200.496044] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.742017] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.256s)
[200.743742] Subtest cursor-fb-leak: SUCCESS (0.535s)
[200.906152] [048/133] (841s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[201.399541] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[201.403447] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[201.515727] [049/133] (841s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[201.591685] Starting subtest: yf-tiled-to-vebox-yf-tiled
[201.595404] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[201.787267] [050/133] (841s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[202.274854] Starting subtest: 2x-long-flip-vs-cursor-legacy
[207.551679] Subtest 2x-long-flip-vs-cursor-legacy: SUCCESS (5.227s)
[207.810964] [051/133] (835s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[207.877780] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[207.942591] [052/133] (835s left) kms_cursor_crc (cursor-random-128x128)
[208.434137] Starting subtest: cursor-random-128x128
[208.452481] Starting dynamic subtest: pipe-A-VGA-1
[212.233593] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.762s)
[212.276423] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.963499] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.689s)
[215.965243] Subtest cursor-random-128x128: SUCCESS (7.500s)
[216.229028] [053/133] (826s left) gem_create (create-ext-placement-all)
[216.407297] Starting subtest: create-ext-placement-all
[216.409501] Subtest create-ext-placement-all: SUCCESS (0.000s)
[216.517513] [054/133] (826s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[217.005026] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[218.426020] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (1.420s)
[218.669645] [055/133] (824s left) kms_setmode (basic)
[218.732806] Starting subtest: basic
[218.867411] Starting dynamic subtest: pipe-A-VGA-1
[223.117552] Dynamic subtest pipe-A-VGA-1: FAIL (4.187s)
[223.135039] Starting dynamic subtest: pipe-B-VGA-1
[227.360892] Dynamic subtest pipe-B-VGA-1: FAIL (4.155s)
[227.377476] Starting dynamic subtest: pipe-A-HDMI-A-1
[231.559069] Dynamic subtest pipe-A-HDMI-A-1: FAIL (4.158s)
[231.594737] Starting dynamic subtest: pipe-B-HDMI-A-1
[235.814139] Dynamic subtest pipe-B-HDMI-A-1: FAIL (4.161s)
[235.854374] Starting dynamic subtest: pipe-A-VGA-1-pipe-B-HDMI-A-1
[240.205370] Dynamic subtest pipe-A-VGA-1-pipe-B-HDMI-A-1: FAIL (4.267s)
[240.280270] Starting dynamic subtest: pipe-B-VGA-1-pipe-A-HDMI-A-1
[244.660326] Dynamic subtest pipe-B-VGA-1-pipe-A-HDMI-A-1: FAIL (4.288s)
[244.675433] Subtest basic: FAIL (25.929s)
[244.946802] [056/133] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[245.440407] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[245.444588] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[245.547024] [057/133] (797s left) kms_cursor_edge_walk (128x128-left-edge)
[246.034844] Starting subtest: 128x128-left-edge
[246.038149] Starting dynamic subtest: pipe-A-VGA-1
[249.450387] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.414s)
[249.464103] Starting dynamic subtest: pipe-B-HDMI-A-1
[252.783467] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.329s)
[252.785111] Subtest 128x128-left-edge: SUCCESS (6.747s)
[253.042347] [058/133] (790s left) kms_draw_crc (draw-method-mmap-wc)
[253.527817] Starting subtest: draw-method-mmap-wc
[253.529512] Starting dynamic subtest: xrgb8888-untiled
[253.857617] Dynamic subtest xrgb8888-untiled: SUCCESS (0.329s)
[253.876616] Starting dynamic subtest: rgb565-untiled
[254.125197] Dynamic subtest rgb565-untiled: SUCCESS (0.265s)
[254.142485] Starting dynamic subtest: xrgb2101010-untiled
[254.392639] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s)
[254.407707] Starting dynamic subtest: xbgr16161616f-untiled
[254.676965] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.282s)
[254.691110] Starting dynamic subtest: xrgb8888-xtiled
[254.827652] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.148s)
[254.842059] Starting dynamic subtest: rgb565-xtiled
[254.977836] Dynamic subtest rgb565-xtiled: SUCCESS (0.148s)
[254.992425] Starting dynamic subtest: xrgb2101010-xtiled
[255.128702] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[255.143197] Starting dynamic subtest: xbgr16161616f-xtiled
[255.279038] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.149s)
[255.281100] Subtest draw-method-mmap-wc: SUCCESS (1.752s)
[255.501319] [059/133] (787s left) perf (buffer-fill)
[255.673374] Subtest buffer-fill: SKIP (0.000s)
[255.728872] [060/133] (787s left) gem_softpin (invalid)
[255.796428] Starting subtest: invalid
[255.798453] Subtest invalid: SUCCESS (0.001s)
[255.914885] [061/133] (787s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[255.977192] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s)
[256.040794] [062/133] (787s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[256.533004] Starting subtest: yf-tiled-32bpp-rotate-0
[256.537371] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[256.636810] [063/133] (786s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[257.123188] Starting subtest: x-tiled-32bpp-rotate-0
[258.575085] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.450s)
[258.810698] [064/133] (784s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[259.301973] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[260.868697] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SUCCESS (1.567s)
[261.017507] [065/133] (782s left) syncobj_wait (single-wait-for-submit-submitted)
[261.083553] Starting subtest: single-wait-for-submit-submitted
[261.188001] Subtest single-wait-for-submit-submitted: SUCCESS (0.103s)
[261.281757] [066/133] (782s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[261.341483] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[261.392760] [067/133] (782s left) kms_psr (fbc-pr-primary-mmap-gtt)
[261.874442] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[261.929681] [068/133] (781s left) gem_exec_balancer (indices)
[261.996519] Subtest indices: SKIP (0.000s)
[262.086106] [069/133] (781s left) kms_content_protection (atomic-hdcp14)
[262.584235] Starting subtest: atomic-hdcp14
[262.588125] Subtest atomic-hdcp14: SKIP (0.000s)
[262.704032] [070/133] (781s left) kms_flip (nonblocking-read)
[263.183689] Starting subtest: nonblocking-read
[263.185544] Subtest nonblocking-read: SUCCESS (0.000s)
[263.295093] [071/133] (780s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[263.784272] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[263.788219] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[263.888906] [072/133] (780s left) gem_ctx_persistence (engines-mixed)
[263.956571] Subtest engines-mixed: SKIP (0.000s)
[264.019521] [073/133] (780s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[264.501110] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[264.505087] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[264.611862] [074/133] (779s left) gem_madvise (dontneed-after-mmap)
[264.672292] Starting subtest: dontneed-after-mmap
[264.678128] Subtest dontneed-after-mmap: SUCCESS (0.007s)
[264.797576] [075/133] (779s left) gem_ccs (block-copy-uncompressed)
[264.866973] Subtest block-copy-uncompressed: SKIP (0.000s)
[264.924880] [076/133] (779s left) gem_mmap_gtt (basic-small-bo-tiledx)
[264.983265] Starting subtest: basic-small-bo-tiledX
[265.235529] Subtest basic-small-bo-tiledX: SUCCESS (0.252s)
[265.370742] [077/133] (778s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[265.939357] Starting subtest: extended-pageflip-modeset-hang-oldfb
[265.941143] Starting dynamic subtest: pipe-A
[272.508859] Dynamic subtest pipe-A: SUCCESS (6.565s)
[272.525942] Starting dynamic subtest: pipe-B
[278.563656] Dynamic subtest pipe-B: SUCCESS (6.050s)
[278.565375] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.621s)
[278.821909] [078/133] (765s left) gem_userptr_blits (process-exit)
[278.908937] Starting subtest: process-exit
[278.924494] Subtest process-exit: SUCCESS (0.015s)
[279.046014] [079/133] (765s left) i915_pciid
[279.204922] [080/133] (765s left) gem_mmap (bad-object)
[279.266547] Starting subtest: bad-object
[279.268211] Subtest bad-object: SUCCESS (0.000s)
[279.367369] [081/133] (765s left) gem_softpin (evict-prime)
[279.435370] Subtest evict-prime: SKIP (0.000s)
[279.532285] [082/133] (765s left) kms_plane_scaling (intel-max-src-size)
[280.007477] Starting subtest: intel-max-src-size
[280.010716] Subtest intel-max-src-size: SKIP (0.000s)
[280.102190] [083/133] (764s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[280.591545] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[280.595435] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[280.702173] [084/133] (763s left) kms_chamelium_hpd (hdmi-hpd-storm)
[281.286257] Subtest hdmi-hpd-storm: SKIP (0.000s)
[281.496178] [085/133] (763s left) gem_lmem_swapping (heavy-verify-random-ccs)
[281.570787] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[281.624827] [086/133] (763s left) kms_dirtyfb (default-dirtyfb-ioctl)
[282.104444] Starting subtest: default-dirtyfb-ioctl
[282.106236] Starting dynamic subtest: A-VGA-1
[283.470690] Dynamic subtest A-VGA-1: SUCCESS (1.365s)
[283.484776] Starting dynamic subtest: A-HDMI-A-1
[284.913895] Dynamic subtest A-HDMI-A-1: SUCCESS (1.439s)
[284.915547] Subtest default-dirtyfb-ioctl: SUCCESS (2.809s)
[285.171994] [087/133] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[285.657984] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[285.662326] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[285.768101] [088/133] (759s left) gem_exec_schedule (u-submit-late-slice)
[285.846372] Subtest u-submit-late-slice: SKIP (0.000s)
[286.051571] [089/133] (758s left) gem_exec_capture (capture-invisible)
[286.117475] Subtest capture-invisible: SKIP (0.000s)
[286.178736] [090/133] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[286.664376] Starting subtest: fbcpsr-2p-rte
[286.668467] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[286.773116] [091/133] (758s left) kms_getfb (getfb2-into-addfb2)
[287.252562] Starting subtest: getfb2-into-addfb2
[287.254843] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[287.369769] [092/133] (757s left) kms_rotation_crc (sprite-rotation-180)
[287.849570] Starting subtest: sprite-rotation-180
[294.614749] Subtest sprite-rotation-180: SUCCESS (6.769s)
[294.827683] [093/133] (750s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[295.203165] Starting subtest: syncobj-timeline-invalid-wait
[295.204922] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[295.428909] [FACT gem_exec_fence (syncobj-timeline-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[295.433880] [094/133] (749s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[295.499602] Starting subtest: etime-multi-wait-available-unsubmitted
[295.603945] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.103s)
[295.697975] [095/133] (749s left) kms_psr (psr-sprite-mmap-gtt)
[296.176536] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[296.249941] [096/133] (749s left) perf_pmu (most-busy-check-all)
[296.314304] Starting subtest: most-busy-check-all
[296.316291] Starting dynamic subtest: rcs0
[296.830821] Dynamic subtest rcs0: SUCCESS (0.517s)
[296.849125] Starting dynamic subtest: bcs0
[297.355867] Dynamic subtest bcs0: SUCCESS (0.523s)
[297.373934] Starting dynamic subtest: vcs0
[297.876700] Dynamic subtest vcs0: SUCCESS (0.518s)
[297.878814] Subtest most-busy-check-all: SUCCESS (1.565s)
[297.983977] [097/133] (747s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[298.469297] Starting subtest: fbc-rgb565-draw-mmap-gtt
[300.259214] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.790s)
[300.483491] [098/133] (744s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[300.970037] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[300.973850] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[301.084637] [099/133] (744s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[301.571715] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[301.575375] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[301.686077] [100/133] (743s left) intel_hwmon (hwmon-write)
[301.751872] Subtest hwmon-write: SKIP (0.000s)
[301.813336] [101/133] (743s left) gem_ctx_param (invalid-param-set)
[301.909765] Starting subtest: invalid-param-set
[301.912630] Subtest invalid-param-set: SUCCESS (0.000s)
[301.997948] [102/133] (743s left) gem_exec_async (forked-writes)
[302.072187] Starting subtest: forked-writes
[302.074061] Starting dynamic subtest: rcs0
[302.087477] Dynamic subtest rcs0: SUCCESS (0.017s)
[302.103502] Starting dynamic subtest: bcs0
[302.105242] Dynamic subtest bcs0: SUCCESS (0.014s)
[302.121377] Starting dynamic subtest: vcs0
[302.127808] Dynamic subtest vcs0: SUCCESS (0.022s)
[302.129633] Subtest forked-writes: SUCCESS (0.060s)
[302.368024] [103/133] (743s left) api_intel_bb (object-reloc-purge-cache)
[302.430833] Starting subtest: object-reloc-purge-cache
[302.433175] Subtest object-reloc-purge-cache: SUCCESS (0.004s)
[302.550387] [104/133] (743s left) gem_exec_reloc (basic-wc-cpu-active)
[302.617377] Starting subtest: basic-wc-cpu-active
[302.726714] Subtest basic-wc-cpu-active: SUCCESS (0.110s)
[303.248008] [105/133] (742s left) kms_addfb_basic (no-handle)
[303.314575] Starting subtest: no-handle
[303.316174] Subtest no-handle: SUCCESS (0.000s)
[303.844181] [106/133] (742s left) gem_exec_schedule (noreorder-corked)
[303.917560] Subtest noreorder-corked: SKIP (0.000s)
[304.130882] [107/133] (741s left) gem_ctx_param (get-priority-new-ctx)
[304.194321] Subtest get-priority-new-ctx: SKIP (0.000s)
[304.291544] [108/133] (741s left) kms_flip (2x-flip-vs-suspend)
[304.774488] Starting subtest: 2x-flip-vs-suspend
[304.776195] Starting dynamic subtest: AB-VGA1-HDMI-A1
[509.386925] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[516.234942] Closing watchdogs
[516.239293] Initializing watchdogs
[516.239347]   /dev/watchdog0
[516.266448] [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)
[516.278823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[516.280428] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[516.281212] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[516.286182] [109/133] (535s left) gen3_render_tiledx_blits
[516.466168] [110/133] (535s left) gem_ctx_param (set-priority-range)
[516.534778] Subtest set-priority-range: SKIP (0.000s)
[516.632535] [111/133] (535s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[517.117329] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[517.121343] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[517.243175] [112/133] (535s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[517.745497] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[519.797941] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.999s)
[520.045904] [113/133] (532s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[520.112277] Starting subtest: framebuffer-vs-set-tiling
[520.113941] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[520.657491] [114/133] (531s left) gem_mmap_gtt (coherency)
[520.727261] Starting subtest: coherency
[520.786839] Subtest coherency: SUCCESS (0.059s)
[520.897875] [115/133] (531s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[521.385996] Starting subtest: plane-upscale-20x20-with-rotation
[521.388075] Starting dynamic subtest: pipe-A
[521.395655] Dynamic subtest pipe-A: SKIP (0.003s)
[521.414006] Starting dynamic subtest: pipe-B
[521.422636] Dynamic subtest pipe-B: SKIP (0.002s)
[521.426776] Subtest plane-upscale-20x20-with-rotation: SKIP (0.008s)
[521.496120] [116/133] (531s left) gem_exec_schedule (semaphore-power)
[521.581767] Subtest semaphore-power: SKIP (0.000s)
[521.783700] [117/133] (530s left) kms_flip (dpms-vs-vblank-race)
[522.276736] Starting subtest: dpms-vs-vblank-race
[522.278455] Starting dynamic subtest: A-VGA1
[525.465994] Dynamic subtest A-VGA1: SUCCESS (3.145s)
[525.485269] Starting dynamic subtest: B-VGA1
[528.516831] Dynamic subtest B-VGA1: SUCCESS (3.019s)
[528.533212] Starting dynamic subtest: A-HDMI-A1
[531.505266] Dynamic subtest A-HDMI-A1: SUCCESS (2.961s)
[531.521405] Starting dynamic subtest: B-HDMI-A1
[534.652115] Dynamic subtest B-HDMI-A1: SUCCESS (3.134s)
[534.655126] Subtest dpms-vs-vblank-race: SUCCESS (12.270s)
[534.916197] [118/133] (517s left) kms_vblank (wait-forked)
[535.408896] Starting subtest: wait-forked
[535.411004] Starting dynamic subtest: pipe-A-VGA-1
[537.775098] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.359s)
[537.798426] Starting dynamic subtest: pipe-A-HDMI-A-1
[540.075580] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.291s)
[540.094608] Starting dynamic subtest: pipe-B-VGA-1
[542.313402] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.231s)
[542.334091] Starting dynamic subtest: pipe-B-HDMI-A-1
[544.637957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.319s)
[544.642300] Subtest wait-forked: SUCCESS (9.210s)
[544.898341] [119/133] (507s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[544.967146] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.000s)
[545.040147] [120/133] (507s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[545.564522] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[545.622081] [121/133] (507s left) kms_addfb_basic (invalid-get-prop-any)
[545.682959] Starting subtest: invalid-get-prop-any
[545.684668] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[546.213370] [122/133] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[546.701031] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[546.705859] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[546.814410] [123/133] (506s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[547.306925] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[547.311585] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[547.420367] [124/133] (505s left) gem_pipe_control_store_loop (reused-buffer)
[547.495123] Starting subtest: reused-buffer
[549.645043] Subtest reused-buffer: SUCCESS (2.149s)
[549.778252] [125/133] (503s left) kms_chamelium_color (ctm-0-50)
[550.258824] Subtest ctm-0-50: SKIP (0.000s)
[550.325255] [126/133] (502s left) kms_plane_alpha_blend (alpha-transparent-fb)
[550.809236] Starting subtest: alpha-transparent-fb
[551.052378] Subtest alpha-transparent-fb: SKIP (0.243s)
[551.415898] [127/133] (501s left) syncobj_timeline (reset-unsignaled)
[551.479809] Starting subtest: reset-unsignaled
[551.481983] Subtest reset-unsignaled: SUCCESS (0.000s)
[551.581107] [128/133] (501s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[552.066108] Starting subtest: 2x-absolute-wf_vblank-interruptible
[552.067869] Starting dynamic subtest: AB-VGA1-HDMI-A1
[582.537725] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.462s)
[582.542163] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (30.467s)
[582.788960] [129/133] (470s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[583.281594] Starting subtest: y-tiled-8bpp-rotate-0
[583.285558] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[583.403775] [130/133] (470s left) kms_joiner (invalid-modeset-force-big-joiner)
[583.885551] Starting subtest: invalid-modeset-force-big-joiner
[583.889536] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[583.987250] [131/133] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[584.476236] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[584.480399] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[584.586320] [132/133] (468s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[584.651180] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[584.712125] [133/133] (468s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[585.188774] Starting subtest: cursorB-vs-flipB-toggle
[596.141271] Subtest cursorB-vs-flipB-toggle: SUCCESS (10.949s)
[596.408575] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_edid
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: gem_pipe_control_store_loop
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: i915_pm_rpm
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: device_reset
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_color
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: sysfs_preempt_timeout
results: parsing output: 14/ for test: prime_busy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_pm_backlight
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_atomic
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_vrr
results: parsing output: 26/ for test: gem_ctx_persistence
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: syncobj_eventfd
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: kms_pm_rpm
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: gem_partial_pwrite_pread
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_plane
results: parsing output: 42/ for test: gem_vm_create
results: parsing output: 43/ for test: i915_suspend
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: gem_exec_gttfill
results: parsing output: 46/ for test: kms_universal_plane
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: gem_create
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_setmode
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_edge_walk
results: parsing output: 57/ for test: kms_draw_crc
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: syncobj_wait
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_exec_balancer
results: parsing output: 68/ for test: kms_content_protection
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_ctx_persistence
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_madvise
results: parsing output: 74/ for test: gem_ccs
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_busy
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: i915_pciid
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: kms_dirtyfb
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_exec_capture
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: intel_hwmon
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: gem_exec_async
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gen3_render_tiledx_blits
results: parsing output: 109/ for test: gem_ctx_param
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_plane_scaling
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_pipe_control_store_loop
results: parsing output: 124/ for test: kms_chamelium_color
results: parsing output: 125/ for test: kms_plane_alpha_blend
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_joiner
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_pipe_b_c_ivb
results: parsing output: 132/ for test: kms_cursor_legacy
Done.