[91.738120] Initializing watchdogs
[91.738263]   /dev/watchdog0
[91.761246] [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)
[91.770847] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[91.775368] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[91.779787] [001/132] (960s left) gem_sync (basic-all)
[91.864545] Starting subtest: basic-all
[93.917194] Subtest basic-all: SUCCESS (2.052s)
[94.112250] [002/132] (958s left) gem_mmap_gtt (zero-extend)
[94.166178] Starting subtest: zero-extend
[94.167340] Subtest zero-extend: SUCCESS (0.000s)
[94.261246] [003/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[94.752644] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[96.726833] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (1.976s)
[96.872283] [004/132] (955s left) prime_self_import (basic-with_two_bos)
[96.925767] Starting subtest: basic-with_two_bos
[96.929332] Subtest basic-with_two_bos: SUCCESS (0.005s)
[97.037779] [005/132] (955s left) gem_readwrite (read-bad-handle)
[97.094018] Starting subtest: read-bad-handle
[97.096257] Subtest read-bad-handle: SUCCESS (0.000s)
[97.206542] [006/132] (955s left) gem_exec_parallel (fds)
[97.274121] Starting subtest: fds
[97.275242] Starting dynamic subtest: rcs0
[99.080369] Dynamic subtest rcs0: SUCCESS (1.806s)
[99.092134] Starting dynamic subtest: bcs0
[100.753704] Dynamic subtest bcs0: SUCCESS (1.673s)
[100.754973] Subtest fds: SUCCESS (3.480s)
[100.965412] [007/132] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[101.459480] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[101.461594] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[101.567320] [008/132] (951s left) gem_exec_schedule (u-fairslice)
[101.636313] Subtest u-fairslice: SKIP (0.000s)
[101.837868] [009/132] (950s left) kms_plane_multiple (2x-tiling-yf)
[102.314898] Starting subtest: 2x-tiling-yf
[102.317428] Subtest 2x-tiling-yf: SKIP (0.000s)
[102.410758] [010/132] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[102.900421] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[102.902868] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[103.009384] [011/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[103.501501] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[103.503948] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[103.607115] [012/132] (949s left) gem_lmem_swapping (basic)
[103.666299] Subtest basic: SKIP (0.000s)
[103.721225] [013/132] (949s left) gem_mmap_wc (bad-size)
[103.777717] Starting subtest: bad-size
[103.778882] Subtest bad-size: SUCCESS (0.001s)
[103.877240] [014/132] (949s left) kms_psr (pr-sprite-plane-onoff)
[104.359561] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[104.422080] [015/132] (948s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[104.914442] Starting subtest: 4-tiled-16bpp-rotate-0
[104.917051] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[105.021129] [016/132] (947s left) syncobj_timeline (etime-single-wait-submitted)
[105.084395] Starting subtest: etime-single-wait-submitted
[105.187631] Subtest etime-single-wait-submitted: SUCCESS (0.103s)
[105.278377] [017/132] (947s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[105.771350] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[105.773995] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[105.884128] [018/132] (947s left) kms_plane (plane-position-hole-dpms)
[106.362841] Starting subtest: plane-position-hole-dpms
[106.712773] Starting dynamic subtest: pipe-A-plane-1
[107.177420] Dynamic subtest pipe-A-plane-1: SUCCESS (0.464s)
[107.187411] Starting dynamic subtest: pipe-A-plane-2
[107.189561] Dynamic subtest pipe-A-plane-2: SUCCESS (0.004s)
[107.503580] Starting dynamic subtest: pipe-B-plane-1
[108.078452] Dynamic subtest pipe-B-plane-1: SUCCESS (0.584s)
[108.088483] Starting dynamic subtest: pipe-B-plane-2
[108.090955] Dynamic subtest pipe-B-plane-2: SUCCESS (0.009s)
[108.091986] Subtest plane-position-hole-dpms: SUCCESS (1.725s)
[108.346714] [019/132] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[108.408485] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[108.515164] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[108.608691] [020/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[109.097325] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[111.106850] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (2.009s)
[111.250456] [021/132] (941s left) gem_mmap_wc (set-cache-level)
[111.306025] Starting subtest: set-cache-level
[111.307156] Subtest set-cache-level: SUCCESS (0.001s)
[111.402286] [022/132] (941s left) kms_vblank (query-busy-hang)
[111.889659] Starting subtest: query-busy-hang
[111.890958] Starting dynamic subtest: pipe-A-VGA-1
[117.930306] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.040s)
[117.941042] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.980347] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.048s)
[123.993789] Starting dynamic subtest: pipe-B-VGA-1
[129.943434] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.963s)
[129.955290] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.929450] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.985s)
[135.932276] Subtest query-busy-hang: SUCCESS (24.042s)
[136.213562] [023/132] (917s left) gem_partial_pwrite_pread (write-display)
[136.279149] Starting subtest: write-display
[140.145567] Subtest write-display: SUCCESS (3.867s)
[140.272941] [024/132] (913s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[140.768509] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[142.183674] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.415s)
[142.413531] [025/132] (910s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[142.895826] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[142.898423] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[142.981375] [026/132] (910s left) gem_ccs (block-multicopy-compressed)
[143.044426] Subtest block-multicopy-compressed: SKIP (0.000s)
[143.106746] [027/132] (910s left) kms_flip (wf_vblank-ts-check-interruptible)
[143.598182] Starting subtest: wf_vblank-ts-check-interruptible
[143.599369] Starting dynamic subtest: A-VGA1
[151.703809] Dynamic subtest A-VGA1: SUCCESS (8.105s)
[151.715592] Starting dynamic subtest: B-VGA1
[159.678323] Dynamic subtest B-VGA1: SUCCESS (7.973s)
[159.693485] Starting dynamic subtest: A-HDMI-A1
[167.835283] Dynamic subtest A-HDMI-A1: SUCCESS (8.155s)
[167.846476] Starting dynamic subtest: B-HDMI-A1
[176.019373] Dynamic subtest B-HDMI-A1: SUCCESS (8.184s)
[176.020540] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.423s)
[176.202307] [028/132] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[176.690363] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[176.691481] Starting dynamic subtest: pipe-A
[176.695862] Dynamic subtest pipe-A: SKIP (0.002s)
[176.708027] Starting dynamic subtest: pipe-B
[176.712815] Dynamic subtest pipe-B: SKIP (0.001s)
[176.715203] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.005s)
[176.788250] [029/132] (876s left) kms_flip (2x-busy-flip)
[177.270958] Starting subtest: 2x-busy-flip
[177.272185] Starting dynamic subtest: AB-VGA1-HDMI-A1
[178.648157] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.376s)
[178.652113] Subtest 2x-busy-flip: SUCCESS (1.380s)
[178.910690] [030/132] (874s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[178.971632] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[179.022213] [031/132] (874s left) kms_chamelium_frames (dp-crc-fast)
[179.616119] Subtest dp-crc-fast: SKIP (0.000s)
[179.826528] [032/132] (873s left) kms_big_fb (linear-8bpp-rotate-270)
[180.320565] Starting subtest: linear-8bpp-rotate-270
[180.415835] Subtest linear-8bpp-rotate-270: SKIP (0.094s)
[180.630324] [033/132] (873s left) gem_madvise (dontneed-before-pwrite)
[180.685399] Starting subtest: dontneed-before-pwrite
[180.687668] Subtest dontneed-before-pwrite: SUCCESS (0.003s)
[180.797357] [034/132] (873s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[181.280886] Starting subtest: primary-4-tiled-reflect-x-0
[181.283218] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[181.379440] [035/132] (872s left) kms_flip (absolute-wf_vblank)
[181.863511] Starting subtest: absolute-wf_vblank
[181.864614] Starting dynamic subtest: A-VGA1
[189.668993] Dynamic subtest A-VGA1: SUCCESS (7.805s)
[189.682044] Starting dynamic subtest: B-VGA1
[197.392550] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[197.405629] Starting dynamic subtest: A-HDMI-A1
[205.284951] Dynamic subtest A-HDMI-A1: SUCCESS (7.890s)
[205.299435] Starting dynamic subtest: B-HDMI-A1
[213.209862] Dynamic subtest B-HDMI-A1: SUCCESS (7.923s)
[213.212211] Subtest absolute-wf_vblank: SUCCESS (31.349s)
[213.388294] [036/132] (840s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[213.446207] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[213.504055] [037/132] (840s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[213.988309] Starting subtest: async-flip-with-page-flip-events-linear
[214.226506] Subtest async-flip-with-page-flip-events-linear: SKIP (0.238s)
[214.471515] [038/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[214.952547] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[216.826278] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.874s)
[216.971465] [039/132] (837s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[217.455281] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[217.520077] [040/132] (836s left) gem_softpin (full)
[217.581986] Subtest full: SKIP (0.000s)
[217.676862] [041/132] (836s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[217.731034] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[217.784925] [042/132] (836s left) kms_cursor_crc (cursor-offscreen-128x42)
[218.275091] Starting subtest: cursor-offscreen-128x42
[218.325906] Subtest cursor-offscreen-128x42: SKIP (0.049s)
[218.437548] [043/132] (835s left) kms_color_pipeline (plane-ctm3x4)
[218.920040] Starting subtest: plane-ctm3x4
[219.555721] Subtest plane-ctm3x4: SKIP (0.633s)
[219.808994] [044/132] (834s left) gem_mmap (bad-size)
[219.869533] Starting subtest: bad-size
[219.870569] Subtest bad-size: SUCCESS (0.001s)
[219.973443] [045/132] (834s left) prime_vgem (basic-fence-mmap)
[220.104314] Starting subtest: basic-fence-mmap
[220.135896] Subtest basic-fence-mmap: SUCCESS (0.034s)
[220.239121] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[220.242261] [046/132] (834s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[220.728836] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[222.749771] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.022s)
[222.899677] [047/132] (831s left) kms_frontbuffer_tracking (psr-suspend)
[223.391334] Starting subtest: psr-suspend
[223.393935] Subtest psr-suspend: SKIP (0.000s)
[223.502416] [048/132] (831s left) gem_exec_params (cliprects-invalid)
[223.564924] Starting subtest: cliprects-invalid
[223.565989] Subtest cliprects-invalid: SUCCESS (0.000s)
[223.666835] [049/132] (830s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[224.147389] Starting subtest: stress-xrgb8888-xtiled
[231.747365] Subtest stress-xrgb8888-xtiled: SUCCESS (7.601s)
[231.951784] [050/132] (822s left) prime_self_import (reimport-vs-gem_close-race)
[232.008296] Starting subtest: reimport-vs-gem_close-race
[237.035492] Subtest reimport-vs-gem_close-race: SUCCESS (5.026s)
[237.142417] [051/132] (817s left) gem_mmap_gtt (hang)
[237.200389] Starting subtest: hang
[242.673867] Subtest hang: SUCCESS (5.468s)
[242.874346] [052/132] (811s left) gem_ctx_param (invalid-ctx-get)
[242.932304] Starting subtest: invalid-ctx-get
[242.933393] Subtest invalid-ctx-get: SUCCESS (0.000s)
[243.032093] [053/132] (811s left) syncobj_timeline (single-wait-signaled)
[243.094377] Starting subtest: single-wait-signaled
[243.095555] Subtest single-wait-signaled: SUCCESS (0.001s)
[243.195329] [054/132] (811s left) gem_exec_balancer (parallel)
[243.255276] Subtest parallel: SKIP (0.000s)
[243.369683] [055/132] (811s left) kms_psr (fbc-psr-cursor-plane-move)
[243.839691] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[243.906312] [056/132] (811s left) gem_ctx_engines (execute-one)
[243.970751] Starting subtest: execute-one
[244.338645] Subtest execute-one: SUCCESS (0.367s)
[244.546690] [057/132] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[245.022827] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[245.025047] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[245.132096] [058/132] (809s left) syncobj_eventfd (timeline-wait)
[245.190312] Starting subtest: timeline-wait
[245.201823] Subtest timeline-wait: SUCCESS (0.011s)
[245.300736] [059/132] (809s left) gem_exec_fence (submit-chain)
[245.473655] Subtest submit-chain: SKIP (0.000s)
[245.851903] [060/132] (809s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[245.922330] Starting subtest: map-fixed-invalidate-overlap-busy
[245.923450] Starting dynamic subtest: gtt
[247.012411] Dynamic subtest gtt: SUCCESS (1.088s)
[247.027296] Starting dynamic subtest: wb
[248.044676] Dynamic subtest wb: SUCCESS (1.031s)
[248.058620] Starting dynamic subtest: wc
[249.083746] Dynamic subtest wc: SUCCESS (1.038s)
[249.095696] Starting dynamic subtest: uc
[250.117601] Dynamic subtest uc: SUCCESS (1.033s)
[250.118804] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.195s)
[250.249467] [061/132] (804s left) kms_fbcon_fbt (psr-suspend)
[250.308378] Starting subtest: psr-suspend
[250.310357] Subtest psr-suspend: SKIP (0.000s)
[250.447539] [062/132] (804s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[250.505457] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[250.506539] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[250.600236] [063/132] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[251.070735] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[251.073079] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[251.184297] [064/132] (804s left) kms_chamelium_color (ctm-blue-to-red)
[251.647532] Subtest ctm-blue-to-red: SKIP (0.000s)
[251.730258] [065/132] (803s left) core_setmaster (master-drop-set-user)
[251.854589] Starting subtest: master-drop-set-user
[251.885482] Subtest master-drop-set-user: SUCCESS (0.031s)
[251.937693] [066/132] (803s left) syncobj_wait (wait-all-complex)
[251.998910] Starting subtest: wait-all-complex
[252.212659] Subtest wait-all-complex: SUCCESS (0.215s)
[252.312253] [067/132] (803s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[252.370845] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[252.372023] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[252.471259] [068/132] (803s left) gem_exec_parallel (userptr)
[252.536663] Starting subtest: userptr
[252.537830] Starting dynamic subtest: rcs0
[254.126489] Dynamic subtest rcs0: SUCCESS (1.589s)
[254.139989] Starting dynamic subtest: bcs0
[259.289559] Dynamic subtest bcs0: SUCCESS (5.161s)
[259.290662] Subtest userptr: SUCCESS (6.754s)
[259.497673] [069/132] (796s left) kms_pm_rpm (pm-tiling)
[271.234083] Subtest pm-tiling: SKIP (0.000s)
[271.290764] [070/132] (784s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[271.774547] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[271.842871] [071/132] (783s left) kms_psr (psr2-cursor-mmap-gtt)
[272.326417] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[272.393626] [072/132] (783s left) i915_pm_rps (waitboost)
[272.459122] Starting subtest: waitboost
[275.993192] Subtest waitboost: SUCCESS (3.534s)
[276.114529] [073/132] (779s left) gem_ctx_persistence (hang)
[276.176347] Subtest hang: SKIP (0.000s)
[276.242177] [074/132] (779s left) kms_psr (fbc-psr2-sprite-blt)
[276.721347] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[276.773749] [075/132] (779s left) kms_lease (empty-lease)
[277.252282] Starting subtest: empty-lease
[277.253370] Starting dynamic subtest: pipe-A-VGA-1
[277.254474] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s)
[277.270455] Starting dynamic subtest: pipe-A-HDMI-A-1
[277.271488] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[277.283286] Starting dynamic subtest: pipe-B-VGA-1
[277.284307] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[277.295515] Starting dynamic subtest: pipe-B-HDMI-A-1
[277.296801] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[277.298014] Subtest empty-lease: SUCCESS (0.015s)
[277.362525] [076/132] (778s left) syncobj_wait (wait-all-for-submit-complex)
[277.420219] Starting subtest: wait-all-for-submit-complex
[277.636985] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[277.730950] [077/132] (778s left) api_intel_bb (reset-bb)
[277.789693] Starting subtest: reset-bb
[277.792406] Subtest reset-bb: SUCCESS (0.002s)
[277.919266] [078/132] (778s left) kms_chamelium_hpd (hdmi-hpd-storm)
[278.495609] Subtest hdmi-hpd-storm: SKIP (0.000s)
[278.747835] [079/132] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[279.234755] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[279.236977] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[279.346624] [080/132] (776s left) gem_exec_schedule (u-submit-late-slice)
[279.418464] Subtest u-submit-late-slice: SKIP (0.000s)
[279.613596] [081/132] (776s left) kms_invalid_mode (int-max-clock)
[280.094413] Starting subtest: int-max-clock
[280.095499] Starting dynamic subtest: pipe-A-VGA-1
[280.213635] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.119s)
[280.227554] Starting dynamic subtest: pipe-A-HDMI-A-1
[280.228967] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[280.241477] Starting dynamic subtest: pipe-B-VGA-1
[280.242573] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[280.253704] Starting dynamic subtest: pipe-B-HDMI-A-1
[280.254877] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[280.255972] Subtest int-max-clock: SUCCESS (0.127s)
[280.480061] [082/132] (775s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[280.544381] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[280.610813] [083/132] (775s left) gem_exec_suspend (basic-s3)
[280.683850] Starting subtest: basic-S3
[280.684941] Starting dynamic subtest: smem
[298.222902] Dynamic subtest smem: SUCCESS (1.518s)
[298.224397] Subtest basic-S3: SUCCESS (1.520s)
[307.450752] [084/132] (758s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[310.025588] Starting subtest: verify-pxp-key-change-after-suspend-resume
[310.027989] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[310.128517] [085/132] (755s left) gem_exec_schedule (pi-common)
[310.202808] Subtest pi-common: SKIP (0.000s)
[310.410973] [086/132] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[310.892240] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[310.894614] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[311.015784] [087/132] (754s left) gem_exec_balancer (parallel-contexts)
[311.076025] Subtest parallel-contexts: SKIP (0.000s)
[311.183589] [088/132] (754s left) i915_hangman (gt-engine-error)
[311.246696] Starting subtest: gt-engine-error
[311.248954] Subtest gt-engine-error: SKIP (0.000s)
[311.336087] [089/132] (754s left) kms_cursor_crc (cursor-random-512x512)
[311.819980] Starting subtest: cursor-random-512x512
[311.822066] Subtest cursor-random-512x512: SKIP (0.001s)
[311.945694] [090/132] (753s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[312.417669] Starting subtest: fb-8bpc-vs-panel-6bpc
[312.419854] Starting dynamic subtest: pipe-A-HDMI-A-1
[312.524201] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.103s)
[312.526626] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.107s)
[312.788818] [091/132] (753s left) perf_pmu (busy-start)
[312.851120] Starting subtest: busy-start
[312.852265] Starting dynamic subtest: rcs0
[315.367940] Dynamic subtest rcs0: SUCCESS (2.523s)
[315.386690] Starting dynamic subtest: bcs0
[317.889747] Dynamic subtest bcs0: SUCCESS (2.522s)
[317.907737] Starting dynamic subtest: vcs0
[320.906855] Dynamic subtest vcs0: SUCCESS (3.018s)
[320.911226] Subtest busy-start: SUCCESS (8.073s)
[321.008751] [092/132] (744s left) gem_fence_thrash (bo-write-verify-threaded-x)
[321.063661] Starting subtest: bo-write-verify-threaded-x
[322.892770] Subtest bo-write-verify-threaded-x: SUCCESS (1.830s)
[323.018009] [093/132] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[323.507821] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[323.510460] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[323.619814] [094/132] (742s left) kms_flip (2x-plain-flip-interruptible)
[324.107961] Starting subtest: 2x-plain-flip-interruptible
[324.110509] Starting dynamic subtest: AB-VGA1-HDMI-A1
[326.477285] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.369s)
[326.480674] Subtest 2x-plain-flip-interruptible: SUCCESS (2.374s)
[326.738601] [095/132] (739s left) gem_exec_reloc (basic-cpu-wc-active)
[326.799607] Starting subtest: basic-cpu-wc-active
[326.909179] Subtest basic-cpu-wc-active: SUCCESS (0.111s)
[327.435745] [096/132] (738s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[327.494753] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[327.566726] [097/132] (738s left) kms_vrr (lobf)
[328.039275] Starting subtest: lobf
[328.042009] Subtest lobf: SKIP (0.000s)
[328.134764] [098/132] (738s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[328.621421] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[328.623888] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[328.737486] [099/132] (737s left) kms_busy (extended-modeset-hang-oldfb)
[329.215159] Starting subtest: extended-modeset-hang-oldfb
[329.216335] Starting dynamic subtest: pipe-A
[335.116972] Dynamic subtest pipe-A: SUCCESS (5.904s)
[335.133471] Starting dynamic subtest: pipe-B
[341.210219] Dynamic subtest pipe-B: SUCCESS (6.095s)
[341.212992] Subtest extended-modeset-hang-oldfb: SUCCESS (12.005s)
[341.490928] [100/132] (724s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[341.559325] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[341.561471] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[341.777594] [101/132] (724s left) sw_sync (sync_multi_producer_single_consumer)
[341.835932] Starting subtest: sync_multi_producer_single_consumer
[342.914311] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[343.015009] [102/132] (723s left) kms_content_protection (dp-mst-type-1)
[343.516760] Starting subtest: dp-mst-type-1
[343.518912] Subtest dp-mst-type-1: SKIP (0.000s)
[343.637499] [103/132] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[344.125781] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[346.043498] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.921s)
[346.273000] [104/132] (720s left) gem_ctx_isolation (preservation-reset)
[346.453485] Starting subtest: preservation-reset
[346.454595] Starting dynamic subtest: rcs0
[346.948741] Dynamic subtest rcs0: SUCCESS (0.495s)
[346.951701] Subtest preservation-reset: SUCCESS (0.498s)
[347.086957] [105/132] (719s left) gem_userptr_blits (probe)
[347.175195] Starting subtest: probe
[347.373045] Subtest probe: SUCCESS (0.198s)
[347.484693] [106/132] (719s left) kms_rotation_crc (exhaust-fences)
[347.964161] Starting subtest: exhaust-fences
[347.966669] Subtest exhaust-fences: SKIP (0.000s)
[348.070898] [107/132] (718s left) kms_feature_discovery (display-4x)
[348.549332] Starting subtest: display-4x
[348.551851] Subtest display-4x: SKIP (0.000s)
[348.653487] [108/132] (718s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[349.134172] Starting subtest: psr-farfromfence-mmap-gtt
[349.136485] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[349.245697] [109/132] (717s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[349.730167] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[349.732154] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[349.859606] [110/132] (717s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[350.353971] Starting subtest: y-tiled-64bpp-rotate-0
[350.356251] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[350.476099] [111/132] (716s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[350.959008] Starting subtest: cursorA-vs-flipB-legacy
[361.896194] Subtest cursorA-vs-flipB-legacy: SUCCESS (10.939s)
[362.166027] [112/132] (704s left) kms_pm_lpsp (screens-disabled)
[373.690364] Starting subtest: screens-disabled
[373.934632] Subtest screens-disabled: SKIP (0.244s)
[374.181741] [113/132] (693s left) syncobj_wait (reset-signaled)
[374.241631] Starting subtest: reset-signaled
[374.242741] Subtest reset-signaled: SUCCESS (0.000s)
[374.352455] [114/132] (692s left) i915_drm_fdinfo (memory-info-resident)
[374.415975] Subtest memory-info-resident: SKIP (0.000s)
[374.489793] [115/132] (692s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[374.552466] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[374.553538] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[374.651495] [116/132] (692s left) i915_pm_rpm (gem-evict-pwrite)
[386.428059] Subtest gem-evict-pwrite: SKIP (0.000s)
[386.500789] [117/132] (680s left) gem_eio (in-flight-internal-immediate)
[386.567720] Starting subtest: in-flight-internal-immediate
[386.601312] Subtest in-flight-internal-immediate: SUCCESS (0.030s)
[387.125805] [118/132] (680s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[387.185498] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[387.254950] [119/132] (680s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[387.315430] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[387.378595] [120/132] (680s left) vgem_basic (dmabuf-mmap)
[387.448521] Starting subtest: dmabuf-mmap
[387.475964] Subtest dmabuf-mmap: SUCCESS (0.030s)
[387.567421] [121/132] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[388.046588] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[388.048879] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[388.172398] [122/132] (679s left) gem_exec_async (forked-writes)
[388.244926] Starting subtest: forked-writes
[388.246155] Starting dynamic subtest: rcs0
[388.263072] Dynamic subtest rcs0: SUCCESS (0.017s)
[388.280705] Starting dynamic subtest: bcs0
[388.281701] Dynamic subtest bcs0: SUCCESS (0.015s)
[388.300202] Starting dynamic subtest: vcs0
[388.305841] Dynamic subtest vcs0: SUCCESS (0.023s)
[388.307064] Subtest forked-writes: SUCCESS (0.062s)
[388.545802] [123/132] (679s left) gem_exec_alignment (single)
[388.615062] Starting subtest: single
[388.618878] Subtest single: SUCCESS (0.004s)
[388.749748] [124/132] (679s left) api_intel_allocator (reserve-simple)
[388.808935] Starting subtest: reserve-simple
[388.813243] Subtest reserve-simple: SUCCESS (0.005s)
[388.950879] [125/132] (678s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[389.007812] Starting subtest: multi-wait-for-submit-available-signaled
[389.008948] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[389.114837] [126/132] (678s left) gen7_exec_parse (batch-without-end)
[389.177190] Subtest batch-without-end: SKIP (0.000s)
[389.242908] [127/132] (678s left) kms_vblank (wait-forked-busy-hang)
[389.719228] Starting subtest: wait-forked-busy-hang
[389.720454] Starting dynamic subtest: pipe-A-VGA-1
[395.963411] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.246s)
[395.984936] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.945745] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.976s)
[401.967615] Starting dynamic subtest: pipe-B-VGA-1
[407.918896] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.965s)
[407.937078] Starting dynamic subtest: pipe-B-HDMI-A-1
[413.976074] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.051s)
[413.977429] Subtest wait-forked-busy-hang: SUCCESS (24.250s)
[414.255156] [128/132] (653s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[414.752135] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[414.848988] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.096s)
[415.074011] [129/132] (653s left) gen3_render_mixed_blits
[415.203263] [130/132] (652s left) kms_psr (fbc-pr-primary-mmap-gtt)
[415.685484] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[415.753121] [131/132] (652s left) kms_cursor_crc (cursor-suspend)
[416.232518] Starting subtest: cursor-suspend
[416.233754] Starting dynamic subtest: pipe-A-VGA-1
[451.113696] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.813s)
[451.129375] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.152008] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.776s)
[486.153063] Subtest cursor-suspend: SUCCESS (3.594s)
[494.449176] [132/132] (581s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[494.937847] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[496.094304] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.162s)
[496.351117] Closing watchdogs
results: parsing output: 0/ for test: gem_sync
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: prime_self_import
results: parsing output: 4/ for test: gem_readwrite
results: parsing output: 5/ for test: gem_exec_parallel
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: kms_plane_multiple
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_lmem_swapping
results: parsing output: 12/ for test: gem_mmap_wc
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: gem_partial_pwrite_pread
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_plane
results: parsing output: 25/ for test: gem_ccs
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_plane_scaling
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: kms_rotation_crc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_flip_scaled_crc
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_mmap
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: kms_pipe_stress
results: parsing output: 49/ for test: prime_self_import
results: parsing output: 50/ for test: gem_mmap_gtt
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_balancer
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_ctx_engines
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_fbcon_fbt
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: core_setmaster
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: syncobj_timeline
results: parsing output: 67/ for test: gem_exec_parallel
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr2_sf
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: i915_pm_rps
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_chamelium_hpd
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_invalid_mode
results: parsing output: 81/ for test: sriov_basic
results: parsing output: 82/ for test: gem_exec_suspend
results: parsing output: 83/ for test: gem_pxp
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: i915_hangman
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: kms_dither
results: parsing output: 90/ for test: perf_pmu
results: parsing output: 91/ for test: gem_fence_thrash
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_vrr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_busy
results: parsing output: 99/ for test: gem_render_copy
results: parsing output: 100/ for test: sw_sync
results: parsing output: 101/ for test: kms_content_protection
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_isolation
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_rotation_crc
results: parsing output: 106/ for test: kms_feature_discovery
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_pm_lpsp
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: i915_drm_fdinfo
results: parsing output: 114/ for test: syncobj_wait
results: parsing output: 115/ for test: i915_pm_rpm
results: parsing output: 116/ for test: gem_eio
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: vgem_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_async
results: parsing output: 122/ for test: gem_exec_alignment
results: parsing output: 123/ for test: api_intel_allocator
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_vblank
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gen3_render_mixed_blits
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_big_fb
Done.