[72.849671] Initializing watchdogs
[72.849794]   /dev/watchdog0
[72.868886] [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.876273] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.879683] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.883815] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[73.500509] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[73.503665] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[73.928582] [002/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[74.310722] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[74.314125] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.744677] [003/131] (958s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[75.113458] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[75.115285] Starting dynamic subtest: pipe-A
[75.120167] Dynamic subtest pipe-A: SKIP (0.001s)
[75.132135] Starting dynamic subtest: pipe-B
[75.137422] Dynamic subtest pipe-B: SKIP (0.001s)
[75.141293] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.003s)
[75.562759] [004/131] (957s left) sysfs_defaults (readonly)
[75.634892] Starting subtest: readonly
[75.636786] Starting dynamic subtest: vcs0
[75.638514] Dynamic subtest vcs0: SUCCESS (0.001s)
[75.649546] Starting dynamic subtest: bcs0
[75.651296] Dynamic subtest bcs0: SUCCESS (0.001s)
[75.665328] Starting dynamic subtest: rcs0
[75.667314] Dynamic subtest rcs0: SUCCESS (0.000s)
[75.669330] Subtest readonly: SUCCESS (0.003s)
[75.729707] [005/131] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt)
[76.111473] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt
[76.114745] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.540025] [006/131] (957s left) gem_exec_balancer (persistence)
[76.609595] Subtest persistence: SKIP (0.000s)
[76.689822] [007/131] (956s left) gem_pxp (verify-pxp-stale-ctx-execution)
[79.270679] Starting subtest: verify-pxp-stale-ctx-execution
[79.274524] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[79.351714] [008/131] (954s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[79.422594] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[79.475258] [009/131] (954s left) kms_flip (2x-modeset-vs-vblank-race)
[79.847204] Starting subtest: 2x-modeset-vs-vblank-race
[79.849037] Starting dynamic subtest: AB-VGA1-HDMI-A1
[90.853324] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (11.004s)
[90.855271] Subtest 2x-modeset-vs-vblank-race: SUCCESS (11.007s)
[91.489987] [010/131] (942s left) prime_self_import (basic-with_two_bos)
[91.594357] Starting subtest: basic-with_two_bos
[91.598204] Subtest basic-with_two_bos: SUCCESS (0.004s)
[91.706308] [011/131] (942s left) core_setmaster (master-drop-set-user)
[91.812319] Starting subtest: master-drop-set-user
[91.834993] Subtest master-drop-set-user: SUCCESS (0.024s)
[91.885194] [012/131] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[92.266446] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[92.269686] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.704288] [013/131] (941s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[93.160794] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[93.500828] [014/131] (940s left) gem_ctx_param (root-set)
[93.567876] Starting subtest: root-set
[93.569961] Subtest root-set: SUCCESS (0.000s)
[93.662555] [015/131] (940s left) gem_ctx_isolation (preservation)
[93.737755] Starting subtest: preservation
[93.739534] Starting dynamic subtest: rcs0
[94.252408] Dynamic subtest rcs0: SUCCESS (0.513s)
[94.254075] Subtest preservation: SUCCESS (0.514s)
[94.482555] [016/131] (939s left) gem_mmap_offset (clear)
[94.548146] Starting subtest: clear
[94.550603] Starting dynamic subtest: smem0
[117.879154] Dynamic subtest smem0: SUCCESS (23.326s)
[117.880751] Subtest clear: SUCCESS (23.328s)
[118.027868] [017/131] (916s left) kms_psr (fbc-psr2-primary-page-flip)
[118.460597] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s)
[118.689535] [018/131] (915s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[118.761133] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[118.828644] [019/131] (915s left) kms_addfb_basic (no-handle)
[118.898663] Starting subtest: no-handle
[118.900261] Subtest no-handle: SUCCESS (0.000s)
[119.644079] [020/131] (914s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[120.018909] Starting subtest: primary-yf-tiled-reflect-x-180
[120.022486] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.001s)
[120.462524] [021/131] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[120.842976] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[120.846421] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[121.275802] [022/131] (913s left) kms_psr2_su (page_flip-xrgb8888)
[121.345939] Subtest page_flip-XRGB8888: SKIP (0.000s)
[121.403350] [023/131] (913s left) gen9_exec_parse (basic-rejected)
[121.473531] Subtest basic-rejected: SKIP (0.000s)
[121.539373] [024/131] (912s left) gem_mmap (bad-offset)
[121.626126] Starting subtest: bad-offset
[121.628140] Subtest bad-offset: SUCCESS (0.000s)
[121.713765] [025/131] (912s left) gem_exec_balancer (bonded-semaphore)
[121.787502] Subtest bonded-semaphore: SKIP (0.000s)
[121.880324] [026/131] (912s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[122.263886] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[122.278245] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.014s)
[122.723573] [027/131] (911s left) kms_flip (2x-flip-vs-panning-interruptible)
[123.107130] Starting subtest: 2x-flip-vs-panning-interruptible
[123.108936] Starting dynamic subtest: AB-VGA1-HDMI-A1
[153.504187] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.398s)
[153.506349] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (30.402s)
[154.141776] [028/131] (880s left) kms_feature_discovery (display-3x)
[154.513742] Starting subtest: display-3x
[154.517744] Subtest display-3x: SKIP (0.000s)
[154.958759] [029/131] (879s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[155.027890] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[155.079646] [030/131] (879s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[155.150210] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[155.212888] [031/131] (879s left) gem_ctx_freq (sysfs)
[155.282141] Starting subtest: sysfs
[155.283867] Starting dynamic subtest: gt0
[160.283684] Dynamic subtest gt0: SUCCESS (5.000s)
[160.285874] Subtest sysfs: SUCCESS (5.002s)
[160.379339] [032/131] (874s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[160.457364] Starting subtest: single-wait-all-for-submit-available-submitted
[160.459141] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[160.549235] [033/131] (874s left) syncobj_basic (bad-pad-fd-to-handle)
[160.622843] Starting subtest: bad-pad-fd-to-handle
[160.624724] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[160.715616] [034/131] (874s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[161.091563] Starting subtest: addfb25-framebuffer-vs-set-tiling
[161.093263] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[161.528633] [035/131] (873s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[161.906752] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[162.138872] [036/131] (872s left) gem_exec_schedule (thriceslice)
[162.224607] Subtest thriceslice: SKIP (0.000s)
[162.428166] [037/131] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[162.803200] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[164.673495] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.872s)
[165.154426] [038/131] (870s left) kms_async_flips (invalid-async-flip)
[165.528956] Starting subtest: invalid-async-flip
[165.533249] Subtest invalid-async-flip: SKIP (0.000s)
[166.202540] [039/131] (869s left) gem_exec_big (single)
[166.276979] Starting subtest: single
[169.487298] Subtest single: SUCCESS (3.211s)
[170.215878] [040/131] (865s left) perf_pmu (busy-idle)
[170.355268] Starting subtest: busy-idle
[170.357295] Starting dynamic subtest: rcs0
[170.990502] Dynamic subtest rcs0: SUCCESS (0.634s)
[171.010336] Starting dynamic subtest: bcs0
[171.632413] Dynamic subtest bcs0: SUCCESS (0.640s)
[171.649498] Starting dynamic subtest: vcs0
[172.775485] Dynamic subtest vcs0: SUCCESS (1.140s)
[172.777623] Subtest busy-idle: SUCCESS (2.421s)
[172.872689] [041/131] (862s left) prime_mmap (test_reprime)
[172.939733] Starting subtest: test_reprime
[172.941635] Starting dynamic subtest: test_reprime-smem
[172.943355] Dynamic subtest test_reprime-smem: SUCCESS (0.004s)
[172.944999] Subtest test_reprime: SUCCESS (0.006s)
[173.054173] [042/131] (862s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[173.440498] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[173.445471] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.001s)
[173.885573] [043/131] (861s left) syncobj_wait (single-wait-all-submitted)
[173.969596] Starting subtest: single-wait-all-submitted
[174.072701] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[174.186081] [044/131] (861s left) kms_getfb (getfb2-handle-zero)
[174.252290] Starting subtest: getfb2-handle-zero
[174.254012] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[174.370333] [045/131] (861s left) i915_pm_rps (thresholds-park)
[174.444997] Starting subtest: thresholds-park
[174.446872] Starting dynamic subtest: gt0
[189.223233] Dynamic subtest gt0: SUCCESS (14.777s)
[189.225358] Subtest thresholds-park: SUCCESS (14.779s)
[189.320502] [046/131] (846s left) gem_exec_whisper (basic-normal)
[189.400164] Starting subtest: basic-normal
[190.597601] Subtest basic-normal: SUCCESS (1.195s)
[190.799452] [047/131] (844s left) syncobj_timeline (device-submit-unordered)
[190.867661] Starting subtest: device-submit-unordered
[190.869420] Subtest device-submit-unordered: SUCCESS (0.001s)
[190.970247] [048/131] (844s left) kms_plane (plane-panning-bottom-right-suspend)
[191.343086] Starting subtest: plane-panning-bottom-right-suspend
[191.344746] Starting dynamic subtest: pipe-A
[209.193166] Dynamic subtest pipe-A: SUCCESS (1.185s)
[209.208557] Starting dynamic subtest: pipe-B
[227.158836] Dynamic subtest pipe-B: SUCCESS (1.226s)
[227.160526] Subtest plane-panning-bottom-right-suspend: SUCCESS (2.415s)
[234.719326] [049/131] (808s left) perf (gen12-unprivileged-single-ctx-counters)
[234.863643] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[234.924362] [050/131] (807s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[234.998032] Starting subtest: basic-wc-cpu-noreloc
[235.002185] Subtest basic-wc-cpu-noreloc: SUCCESS (0.002s)
[235.769859] [051/131] (807s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[236.160334] Starting subtest: fbc-rgb565-draw-render
[238.077108] Subtest fbc-rgb565-draw-render: SUCCESS (1.868s)
[238.556011] [052/131] (804s left) gem_softpin (32b-excludes-last-page)
[238.632714] Subtest 32b-excludes-last-page: SKIP (0.000s)
[238.719528] [053/131] (804s left) kms_cursor_crc (cursor-onscreen-32x10)
[239.105672] Starting subtest: cursor-onscreen-32x10
[239.159547] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[239.610639] [054/131] (803s left) kms_psr (fbc-psr-primary-blt)
[239.997431] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[240.225954] [055/131] (802s left) gem_exec_reloc (basic-wc-gtt-active)
[240.299996] Starting subtest: basic-wc-gtt-active
[240.409866] Subtest basic-wc-gtt-active: SUCCESS (0.109s)
[241.179241] [056/131] (802s left) kms_addfb_basic (too-high)
[241.554283] Starting subtest: too-high
[241.555914] Subtest too-high: SUCCESS (0.001s)
[241.996292] [057/131] (801s left) gem_exec_reloc (basic-wc-read)
[242.068055] Starting subtest: basic-wc-read
[242.069753] Subtest basic-wc-read: SUCCESS (0.003s)
[242.847791] [058/131] (800s left) syncobj_wait (wait-all-snapshot)
[242.922366] Starting subtest: wait-all-snapshot
[243.005977] Subtest wait-all-snapshot: SUCCESS (0.081s)
[243.100029] [059/131] (800s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[243.482213] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[243.487171] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[243.929648] [060/131] (799s left) kms_big_fb (linear-32bpp-rotate-0)
[244.316712] Starting subtest: linear-32bpp-rotate-0
[245.856166] Subtest linear-32bpp-rotate-0: SUCCESS (1.524s)
[246.329611] [061/131] (797s left) gem_ctx_shared (q-promotion)
[246.403287] Subtest Q-promotion: SKIP (0.000s)
[246.497199] [062/131] (797s left) kms_pm_rpm (basic-rte)
[246.564486] Starting subtest: basic-rte
[248.071359] Subtest basic-rte: SKIP (1.492s)
[248.323960] [063/131] (795s left) gem_mmap_gtt (coherency)
[248.391637] Starting subtest: coherency
[248.449920] Subtest coherency: SUCCESS (0.059s)
[248.573539] [064/131] (795s left) gem_exec_fence (syncobj-repeat)
[248.830935] Starting subtest: syncobj-repeat
[249.263482] Subtest syncobj-repeat: SUCCESS (0.428s)
[249.613016] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[249.617524] [065/131] (794s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[249.685583] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[249.758540] [066/131] (794s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[250.135582] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[250.140304] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[250.585768] [067/131] (793s left) kms_draw_crc (draw-method-mmap-cpu)
[250.961705] Starting subtest: draw-method-mmap-cpu
[250.963995] Starting dynamic subtest: xrgb8888-untiled
[251.244712] Dynamic subtest xrgb8888-untiled: SUCCESS (0.282s)
[251.262111] Starting dynamic subtest: rgb565-untiled
[251.528631] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[251.545555] Starting dynamic subtest: xrgb2101010-untiled
[251.829404] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[251.845623] Starting dynamic subtest: xbgr16161616f-untiled
[252.179984] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.346s)
[252.196683] Starting dynamic subtest: xrgb8888-xtiled
[252.363616] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.179s)
[252.381129] Starting dynamic subtest: rgb565-xtiled
[252.547255] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s)
[252.563767] Starting dynamic subtest: xrgb2101010-xtiled
[252.732258] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[252.745554] Starting dynamic subtest: xbgr16161616f-xtiled
[252.948111] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.213s)
[252.950096] Subtest draw-method-mmap-cpu: SUCCESS (1.981s)
[253.406629] [068/131] (790s left) drm_fdinfo (busy-check-all)
[253.480454] Subtest busy-check-all: SKIP (0.000s)
[253.551929] [069/131] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[253.936143] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[253.967189] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[254.374435] [070/131] (789s left) syncobj_wait (reset-signaled)
[254.443164] Starting subtest: reset-signaled
[254.444793] Subtest reset-signaled: SUCCESS (0.000s)
[254.541335] [071/131] (789s left) drm_fdinfo (virtual-busy-all)
[254.606656] Subtest virtual-busy-all: SKIP (0.000s)
[254.666015] [072/131] (789s left) kms_vrr (flipline)
[255.038511] Starting subtest: flipline
[255.043843] Subtest flipline: SKIP (0.000s)
[255.491563] [073/131] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[255.867110] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[255.870701] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[256.310399] [074/131] (788s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[256.385669] Starting subtest: tiled-to-untiled
[256.415822] Subtest tiled-to-untiled: SUCCESS (0.030s)
[256.561833] [075/131] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[256.943555] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[256.946883] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[257.391570] [076/131] (787s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[257.765394] Starting subtest: yf-tiled-16bpp-rotate-90
[257.770920] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[258.214513] [077/131] (786s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[258.286316] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[258.386873] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[258.494289] [078/131] (786s left) kms_legacy_colorkey (invalid-plane)
[258.865203] Starting subtest: invalid-plane
[258.866902] Starting dynamic subtest: zero-id
[258.868693] Dynamic subtest zero-id: SUCCESS (0.000s)
[258.886505] Starting dynamic subtest: outrange-id
[258.888543] Dynamic subtest outrange-id: SUCCESS (0.000s)
[258.890350] Subtest invalid-plane: SUCCESS (0.003s)
[259.311419] [079/131] (785s left) gem_exec_schedule (preempt-queue-contexts-chain)
[259.392225] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[259.590101] [080/131] (785s left) gem_pread (self)
[259.657508] Starting subtest: self
[259.681891] Subtest self: SUCCESS (0.026s)
[259.793375] [081/131] (784s left) kms_chamelium_color (ctm-0-50)
[260.165281] Subtest ctm-0-50: SKIP (0.000s)
[260.420765] [082/131] (784s left) gem_exec_flush (basic-wb-rw-default)
[260.501150] Starting subtest: basic-wb-rw-default
[265.980559] Subtest basic-wb-rw-default: SUCCESS (5.474s)
[266.188133] [083/131] (778s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[266.258333] Starting subtest: invalid-single-wait-all-unsubmitted
[266.260055] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[266.354693] [084/131] (778s left) kms_atomic_transition (modeset-transition-fencing)
[266.730758] Starting subtest: modeset-transition-fencing
[266.732568] Starting dynamic subtest: 1x-outputs
[267.656536] Dynamic subtest 1x-outputs: SUCCESS (0.924s)
[267.690010] Subtest modeset-transition-fencing: SUCCESS (0.960s)
[268.249924] [085/131] (776s left) kms_addfb_basic (tile-pitch-mismatch)
[268.324548] Starting subtest: tile-pitch-mismatch
[268.326320] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[269.075428] [086/131] (775s left) kms_psr (psr-primary-mmap-cpu)
[269.447414] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[269.706012] [087/131] (775s left) kms_psr (pr-sprite-plane-onoff)
[270.079562] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[270.317685] [088/131] (774s left) kms_content_protection (dp-mst-lic-type-0)
[270.713168] Starting subtest: dp-mst-lic-type-0
[270.716654] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[271.158005] [089/131] (774s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[271.231781] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[271.304771] [090/131] (774s left) kms_vblank (invalid)
[271.667930] Starting subtest: invalid
[271.670218] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.864606] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.195s)
[271.866357] Subtest invalid: SUCCESS (0.198s)
[272.417657] [091/131] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[272.797144] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[272.800390] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[273.249686] [092/131] (772s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[273.625609] Starting subtest: y-tiled-16bpp-rotate-90
[273.629053] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[274.081291] [093/131] (771s left) gem_spin_batch (user-each)
[274.163960] Starting subtest: user-each
[277.505316] Subtest user-each: SUCCESS (3.341s)
[277.741491] [094/131] (767s left) kms_prime (d3hot)
[278.132531] Subtest D3hot: SKIP (0.000s)
[278.992620] [095/131] (766s left) kms_flip (2x-flip-vs-modeset)
[279.357784] Starting subtest: 2x-flip-vs-modeset
[279.359609] Starting dynamic subtest: AB-VGA1-HDMI-A1
[281.806684] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.445s)
[281.810044] Subtest 2x-flip-vs-modeset: SUCCESS (2.448s)
[282.389401] [096/131] (763s left) kms_psr (psr-sprite-mmap-gtt)
[282.791609] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[283.040193] [097/131] (762s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[283.410937] Starting subtest: cursorB-vs-flipA-legacy
[283.414551] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[283.851367] [098/131] (761s left) gem_exec_schedule (fairslice)
[283.937622] Subtest fairslice: SKIP (0.000s)
[284.144279] [099/131] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[284.514437] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[284.518923] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[284.955424] [100/131] (760s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[285.331040] Starting subtest: psr-rgb565-draw-mmap-wc
[285.335417] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[285.767273] [101/131] (760s left) gem_partial_pwrite_pread (reads-display)
[285.866568] Starting subtest: reads-display
[286.846458] Subtest reads-display: SUCCESS (0.978s)
[286.963942] [102/131] (759s left) kms_plane_scaling (planes-upscale-20x20)
[287.331714] Starting subtest: planes-upscale-20x20
[287.333582] Starting dynamic subtest: pipe-A
[287.338546] Dynamic subtest pipe-A: SKIP (0.001s)
[287.356220] Starting dynamic subtest: pipe-B
[287.361905] Dynamic subtest pipe-B: SKIP (0.001s)
[287.365704] Subtest planes-upscale-20x20: SKIP (0.005s)
[287.780344] [103/131] (758s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[288.152744] Starting subtest: compare-crc-sanitycheck-nv12
[288.182311] Starting dynamic subtest: pipe-A-HDMI-A-1
[288.186945] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[288.204004] Starting dynamic subtest: pipe-B-HDMI-A-1
[288.207119] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[288.210238] Subtest compare-crc-sanitycheck-nv12: SKIP (0.006s)
[288.609049] [104/131] (757s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[288.976908] Starting subtest: 2x-flip-vs-modeset-vs-hang
[288.978522] Starting dynamic subtest: AB-VGA1-HDMI-A1
[301.349291] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.365s)
[301.350948] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (12.368s)
[301.907138] [105/131] (744s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[301.979705] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.000s)
[302.051487] [106/131] (744s left) kms_invalid_mode (bad-hsync-start)
[302.421812] Starting subtest: bad-hsync-start
[302.423642] Starting dynamic subtest: pipe-A-HDMI-A-1
[302.493320] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.070s)
[302.508704] Starting dynamic subtest: pipe-B-HDMI-A-1
[302.511104] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[302.513390] Subtest bad-hsync-start: SUCCESS (0.075s)
[303.050156] [107/131] (743s left) intel_sysfs_debugfs (i915-debugfs-read-all-entries)
[303.129635] Starting subtest: i915-debugfs-read-all-entries
[303.279937] Subtest i915-debugfs-read-all-entries: SUCCESS (0.150s)
[304.047631] [108/131] (742s left) i915_hangman (engine-error-state-capture)
[304.122787] Subtest engine-error-state-capture: SKIP (0.000s)
[304.209563] [109/131] (742s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[304.290861] Starting subtest: y-tiled-ccs-to-x-tiled
[304.292756] Starting dynamic subtest: smem
[304.296951] Dynamic subtest smem: SKIP (0.000s)
[304.301321] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.001s)
[304.500064] [110/131] (742s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[304.876679] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[304.880029] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[305.331569] [111/131] (741s left) gem_mmap_gtt (basic-small-copy-odd)
[305.402310] Starting subtest: basic-small-copy-odd
[305.971228] Subtest basic-small-copy-odd: SUCCESS (0.570s)
[306.086693] [112/131] (740s left) gem_ccs (block-copy-compressed)
[306.228537] Subtest block-copy-compressed: SKIP (0.000s)
[306.313978] [113/131] (740s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[306.398515] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[306.471240] [114/131] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt)
[306.860326] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt
[306.864028] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s)
[307.316071] [115/131] (739s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[307.702908] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[307.706583] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[308.144982] [116/131] (738s left) gem_mmap_gtt (big-bo)
[308.212607] Starting subtest: big-bo
[308.499402] Subtest big-bo: SUCCESS (0.284s)
[308.650717] [117/131] (738s left) gem_exec_params (sol-reset-not-gen7)
[308.787600] Starting subtest: sol-reset-not-gen7
[308.789520] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[308.905350] [118/131] (738s left) kms_cursor_edge_walk (128x128-top-edge)
[309.286131] Starting subtest: 128x128-top-edge
[309.287765] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.754849] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.466s)
[312.771296] Starting dynamic subtest: pipe-B-HDMI-A-1
[316.103312] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.343s)
[316.104997] Subtest 128x128-top-edge: SUCCESS (6.815s)
[316.664498] [119/131] (730s left) gem_vm_create (invalid-destroy)
[316.734685] Subtest invalid-destroy: SKIP (0.000s)
[316.803023] [120/131] (730s left) prime_busy (hang)
[316.872859] Starting subtest: hang
[316.874723] Starting dynamic subtest: rcs0
[323.364471] Dynamic subtest rcs0: SUCCESS (6.485s)
[323.378314] Starting dynamic subtest: bcs0
[329.312756] Dynamic subtest bcs0: SUCCESS (5.951s)
[329.327249] Starting dynamic subtest: vcs0
[335.328734] Dynamic subtest vcs0: SUCCESS (6.016s)
[335.330465] Subtest hang: SUCCESS (18.458s)
[335.474103] [121/131] (711s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[335.854237] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[336.088135] [122/131] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[336.474839] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[336.478123] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[336.975994] [123/131] (710s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[337.451535] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[337.475389] Starting dynamic subtest: AB-VGA1-HDMI-A1
[367.798874] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.402s)
[367.800973] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (30.406s)
[368.470755] [124/131] (679s left) api_intel_allocator (reserve-simple)
[368.545690] Starting subtest: reserve-simple
[368.549777] Subtest reserve-simple: SUCCESS (0.005s)
[368.688422] [125/131] (678s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[369.064775] Starting subtest: cursor-rapid-movement-32x32
[369.116950] Subtest cursor-rapid-movement-32x32: SKIP (0.050s)
[369.563202] [126/131] (678s left) kms_chamelium_hpd (vga-hpd-fast)
[370.004621] Subtest vga-hpd-fast: SKIP (0.000s)
[370.346509] [127/131] (677s left) syncobj_timeline (reset-signaled)
[370.420056] Starting subtest: reset-signaled
[370.421866] Subtest reset-signaled: SUCCESS (0.001s)
[370.522286] [128/131] (677s left) gem_exec_flush (basic-uc-ro-default)
[370.605658] Starting subtest: basic-uc-ro-default
[376.075235] Subtest basic-uc-ro-default: SUCCESS (5.469s)
[376.292032] [129/131] (671s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[376.672968] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[376.676318] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[377.117920] [130/131] (670s left) sw_sync (alloc_fence)
[377.188783] Starting subtest: alloc_fence
[377.190695] Subtest alloc_fence: SUCCESS (0.000s)
[377.275562] [131/131] (670s left) sw_sync (sync_expired_merge)
[377.342917] Starting subtest: sync_expired_merge
[378.418047] Subtest sync_expired_merge: SUCCESS (1.074s)
[378.509011] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: sysfs_defaults
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_balancer
results: parsing output: 6/ for test: gem_pxp
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: prime_self_import
results: parsing output: 10/ for test: core_setmaster
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: gem_ctx_isolation
results: parsing output: 15/ for test: gem_mmap_offset
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_mmap
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_feature_discovery
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_ctx_freq
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_async_flips
results: parsing output: 38/ for test: gem_exec_big
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: prime_mmap
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_getfb
results: parsing output: 44/ for test: i915_pm_rps
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_plane
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_ctx_shared
results: parsing output: 61/ for test: kms_pm_rpm
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: drm_fdinfo
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: syncobj_wait
results: parsing output: 70/ for test: drm_fdinfo
results: parsing output: 71/ for test: kms_vrr
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_set_tiling_vs_blt
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_legacy_colorkey
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: gem_pread
results: parsing output: 80/ for test: kms_chamelium_color
results: parsing output: 81/ for test: gem_exec_flush
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_spin_batch
results: parsing output: 93/ for test: kms_prime
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_partial_pwrite_pread
results: parsing output: 101/ for test: kms_plane_scaling
results: parsing output: 102/ for test: kms_pipe_crc_basic
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: intel_sysfs_debugfs
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_mmap_gtt
results: parsing output: 111/ for test: gem_ccs
results: parsing output: 112/ for test: gem_lmem_swapping
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_mmap_gtt
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: kms_cursor_edge_walk
results: parsing output: 118/ for test: gem_vm_create
results: parsing output: 119/ for test: prime_busy
results: parsing output: 120/ for test: kms_psr2_sf
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_exec_flush
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: sw_sync
Done.