[69.583392] Initializing watchdogs
[69.583585]   /dev/watchdog0
[69.604451] [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)
[69.612668] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.616772] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.621259] [001/132] (960s left) gem_sync (basic-all)
[69.707665] Starting subtest: basic-all
[71.754743] Subtest basic-all: SUCCESS (2.050s)
[71.955134] [002/132] (958s left) gem_mmap_gtt (zero-extend)
[72.017760] Starting subtest: zero-extend
[72.018447] Subtest zero-extend: SUCCESS (0.000s)
[72.112642] [003/132] (958s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[72.596866] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[74.587397] Subtest fbc-2p-primscrn-indfb-msflip-blt: SUCCESS (1.992s)
[74.732934] [004/132] (955s left) prime_self_import (basic-with_two_bos)
[74.788795] Starting subtest: basic-with_two_bos
[74.792504] Subtest basic-with_two_bos: SUCCESS (0.004s)
[74.897362] [005/132] (955s left) gem_readwrite (read-bad-handle)
[74.955041] Starting subtest: read-bad-handle
[74.956115] Subtest read-bad-handle: SUCCESS (0.000s)
[75.045202] [006/132] (955s left) gem_exec_parallel (fds)
[75.109674] Starting subtest: fds
[75.110448] Starting dynamic subtest: rcs0
[76.931613] Dynamic subtest rcs0: SUCCESS (1.823s)
[76.946426] Starting dynamic subtest: bcs0
[78.656287] Dynamic subtest bcs0: SUCCESS (1.724s)
[78.657332] Subtest fds: SUCCESS (3.548s)
[78.869285] [007/132] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[79.361440] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[79.362577] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[79.458118] [008/132] (950s left) gem_exec_schedule (u-fairslice)
[79.531880] Subtest u-fairslice: SKIP (0.000s)
[79.725348] [009/132] (950s left) kms_plane_multiple (2x-tiling-yf)
[80.199173] Starting subtest: 2x-tiling-yf
[80.200931] Subtest 2x-tiling-yf: SKIP (0.000s)
[80.287744] [010/132] (950s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[80.785352] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[80.786402] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[80.881544] [011/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[81.370614] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[81.371793] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[81.463601] [012/132] (949s left) gem_lmem_swapping (basic)
[81.523764] Subtest basic: SKIP (0.000s)
[81.575396] [013/132] (949s left) gem_mmap_wc (bad-size)
[81.629828] Starting subtest: bad-size
[81.630993] Subtest bad-size: SUCCESS (0.001s)
[81.730855] [014/132] (948s left) kms_psr (pr-sprite-plane-onoff)
[82.207703] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[82.261827] [015/132] (948s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[82.759898] Starting subtest: 4-tiled-16bpp-rotate-0
[82.761144] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s)
[82.861953] [016/132] (947s left) syncobj_timeline (etime-single-wait-submitted)
[82.922221] Starting subtest: etime-single-wait-submitted
[83.031168] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[83.119067] [017/132] (947s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[83.604287] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[83.605512] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[83.709948] [018/132] (947s left) kms_plane (plane-position-hole-dpms)
[84.194859] Starting subtest: plane-position-hole-dpms
[84.536205] Starting dynamic subtest: pipe-A-plane-1
[85.005115] Dynamic subtest pipe-A-plane-1: SUCCESS (0.467s)
[85.015493] Starting dynamic subtest: pipe-A-plane-2
[85.016535] Dynamic subtest pipe-A-plane-2: SUCCESS (0.004s)
[85.317308] Starting dynamic subtest: pipe-B-plane-1
[85.885282] Dynamic subtest pipe-B-plane-1: SUCCESS (0.581s)
[85.894734] Starting dynamic subtest: pipe-B-plane-2
[85.897323] Dynamic subtest pipe-B-plane-2: SUCCESS (0.012s)
[85.897878] Subtest plane-position-hole-dpms: SUCCESS (1.703s)
[86.158543] [019/132] (944s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[86.221552] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[86.326584] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[86.421366] [020/132] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[86.916183] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[88.869389] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (1.953s)
[89.016710] [021/132] (941s left) gem_mmap_wc (set-cache-level)
[89.073730] Starting subtest: set-cache-level
[89.074285] Subtest set-cache-level: SUCCESS (0.001s)
[89.162029] [022/132] (941s left) kms_vblank (query-busy-hang)
[89.639979] Starting subtest: query-busy-hang
[89.642035] Starting dynamic subtest: pipe-A-VGA-1
[95.911514] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.270s)
[95.925427] Starting dynamic subtest: pipe-A-HDMI-A-1
[101.955466] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.041s)
[101.967560] Starting dynamic subtest: pipe-B-VGA-1
[107.941652] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.985s)
[107.953901] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.976502] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.032s)
[113.977009] Subtest query-busy-hang: SUCCESS (24.334s)
[114.237934] [023/132] (916s left) gem_partial_pwrite_pread (write-display)
[114.299215] Starting subtest: write-display
[118.189417] Subtest write-display: SUCCESS (3.890s)
[118.311843] [024/132] (912s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[118.802491] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[120.210716] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.408s)
[120.423362] [025/132] (910s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[120.907123] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[120.908303] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[120.991328] [026/132] (910s left) gem_ccs (block-multicopy-compressed)
[121.051683] Subtest block-multicopy-compressed: SKIP (0.000s)
[121.098245] [027/132] (910s left) kms_flip (wf_vblank-ts-check-interruptible)
[121.589562] Starting subtest: wf_vblank-ts-check-interruptible
[121.590276] Starting dynamic subtest: A-VGA1
[129.698080] Dynamic subtest A-VGA1: SUCCESS (8.107s)
[129.710859] Starting dynamic subtest: B-VGA1
[137.681324] Dynamic subtest B-VGA1: SUCCESS (7.980s)
[137.695703] Starting dynamic subtest: A-HDMI-A1
[145.841091] Dynamic subtest A-HDMI-A1: SUCCESS (8.156s)
[145.853269] Starting dynamic subtest: B-HDMI-A1
[154.037477] Dynamic subtest B-HDMI-A1: SUCCESS (8.196s)
[154.038679] Subtest wf_vblank-ts-check-interruptible: SUCCESS (32.449s)
[154.218743] [028/132] (877s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[154.698208] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[154.698868] Starting dynamic subtest: pipe-A
[154.701427] Dynamic subtest pipe-A: SKIP (0.002s)
[154.712859] Starting dynamic subtest: pipe-B
[154.715760] Dynamic subtest pipe-B: SKIP (0.002s)
[154.716995] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.006s)
[154.798338] [029/132] (876s left) kms_flip (2x-busy-flip)
[155.282758] Starting subtest: 2x-busy-flip
[155.284753] Starting dynamic subtest: AB-VGA1-HDMI-A1
[156.692641] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.407s)
[156.694715] Subtest 2x-busy-flip: SUCCESS (1.412s)
[156.944023] [030/132] (874s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[156.999961] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[157.058129] [031/132] (874s left) kms_chamelium_frames (dp-crc-fast)
[157.653704] Subtest dp-crc-fast: SKIP (0.000s)
[157.858324] [032/132] (873s left) kms_big_fb (linear-8bpp-rotate-270)
[158.350489] Starting subtest: linear-8bpp-rotate-270
[158.452691] Subtest linear-8bpp-rotate-270: SKIP (0.101s)
[158.666798] [033/132] (872s left) gem_madvise (dontneed-before-pwrite)
[158.719637] Starting subtest: dontneed-before-pwrite
[158.722673] Subtest dontneed-before-pwrite: SUCCESS (0.003s)
[158.825292] [034/132] (872s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[159.307485] Starting subtest: primary-4-tiled-reflect-x-0
[159.308919] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[159.398746] [035/132] (872s left) kms_flip (absolute-wf_vblank)
[159.881877] Starting subtest: absolute-wf_vblank
[159.883780] Starting dynamic subtest: A-VGA1
[167.687326] Dynamic subtest A-VGA1: SUCCESS (7.804s)
[167.699604] Starting dynamic subtest: B-VGA1
[175.412907] Dynamic subtest B-VGA1: SUCCESS (7.724s)
[175.426123] Starting dynamic subtest: A-HDMI-A1
[183.305256] Dynamic subtest A-HDMI-A1: SUCCESS (7.889s)
[183.319176] Starting dynamic subtest: B-HDMI-A1
[191.223611] Dynamic subtest B-HDMI-A1: SUCCESS (7.916s)
[191.228219] Subtest absolute-wf_vblank: SUCCESS (31.344s)
[191.401911] [036/132] (840s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[191.461093] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[191.512249] [037/132] (840s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[191.992328] Starting subtest: async-flip-with-page-flip-events-linear
[192.222206] Subtest async-flip-with-page-flip-events-linear: SKIP (0.231s)
[192.462257] [038/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[192.948162] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[194.838278] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.890s)
[194.970461] [039/132] (836s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[195.452012] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[195.509742] [040/132] (836s left) gem_softpin (full)
[195.570975] Subtest full: SKIP (0.000s)
[195.665907] [041/132] (836s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[195.723949] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[195.779300] [042/132] (836s left) kms_cursor_crc (cursor-offscreen-128x42)
[196.263933] Starting subtest: cursor-offscreen-128x42
[196.317104] Subtest cursor-offscreen-128x42: SKIP (0.052s)
[196.429254] [043/132] (835s left) kms_color_pipeline (plane-ctm3x4)
[196.906050] Starting subtest: plane-ctm3x4
[197.531769] Subtest plane-ctm3x4: SKIP (0.626s)
[197.764296] [044/132] (834s left) gem_mmap (bad-size)
[197.822337] Starting subtest: bad-size
[197.823784] Subtest bad-size: SUCCESS (0.001s)
[197.933101] [045/132] (834s left) prime_vgem (basic-fence-mmap)
[198.063659] Starting subtest: basic-fence-mmap
[198.100658] Subtest basic-fence-mmap: SUCCESS (0.037s)
[198.214773] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[198.217938] [046/132] (833s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[198.701163] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[200.710566] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.009s)
[200.843310] [047/132] (831s left) kms_frontbuffer_tracking (psr-suspend)
[201.332726] Starting subtest: psr-suspend
[201.333676] Subtest psr-suspend: SKIP (0.000s)
[201.441687] [048/132] (830s left) gem_exec_params (cliprects-invalid)
[201.502116] Starting subtest: cliprects-invalid
[201.502793] Subtest cliprects-invalid: SUCCESS (0.000s)
[201.611888] [049/132] (830s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[202.092447] Starting subtest: stress-xrgb8888-xtiled
[213.414321] Subtest stress-xrgb8888-xtiled: SUCCESS (11.322s)
[213.703804] [050/132] (818s left) prime_self_import (reimport-vs-gem_close-race)
[213.758142] Starting subtest: reimport-vs-gem_close-race
[218.784063] Subtest reimport-vs-gem_close-race: SUCCESS (5.025s)
[218.880249] [051/132] (813s left) gem_mmap_gtt (hang)
[218.936022] Starting subtest: hang
[224.406106] Subtest hang: SUCCESS (5.470s)
[224.598447] [052/132] (807s left) gem_ctx_param (invalid-ctx-get)
[224.655744] Starting subtest: invalid-ctx-get
[224.656389] Subtest invalid-ctx-get: SUCCESS (0.000s)
[224.749922] [053/132] (807s left) syncobj_timeline (single-wait-signaled)
[224.807234] Starting subtest: single-wait-signaled
[224.807870] Subtest single-wait-signaled: SUCCESS (0.001s)
[224.899798] [054/132] (807s left) gem_exec_balancer (parallel)
[224.959097] Subtest parallel: SKIP (0.000s)
[225.052538] [055/132] (807s left) kms_psr (fbc-psr-cursor-plane-move)
[225.514368] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[225.579681] [056/132] (807s left) gem_ctx_engines (execute-one)
[225.643549] Starting subtest: execute-one
[226.008431] Subtest execute-one: SUCCESS (0.365s)
[226.216472] [057/132] (806s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[226.684960] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[226.686340] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[226.783810] [058/132] (805s left) syncobj_eventfd (timeline-wait)
[226.841657] Starting subtest: timeline-wait
[226.852141] Subtest timeline-wait: SUCCESS (0.011s)
[226.952939] [059/132] (805s left) gem_exec_fence (submit-chain)
[227.125143] Subtest submit-chain: SKIP (0.000s)
[227.493436] [060/132] (805s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[227.564708] Starting subtest: map-fixed-invalidate-overlap-busy
[227.565506] Starting dynamic subtest: gtt
[228.654598] Dynamic subtest gtt: SUCCESS (1.089s)
[228.670218] Starting dynamic subtest: wb
[229.727422] Dynamic subtest wb: SUCCESS (1.071s)
[229.745836] Starting dynamic subtest: wc
[230.766791] Dynamic subtest wc: SUCCESS (1.038s)
[230.779704] Starting dynamic subtest: uc
[231.790492] Dynamic subtest uc: SUCCESS (1.022s)
[231.794142] Subtest map-fixed-invalidate-overlap-busy: SUCCESS (4.227s)
[231.933874] [061/132] (800s left) kms_fbcon_fbt (psr-suspend)
[231.990267] Starting subtest: psr-suspend
[231.991463] Subtest psr-suspend: SKIP (0.000s)
[232.136122] [062/132] (800s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[232.193607] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[232.194369] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[232.299533] [063/132] (800s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[232.777970] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[232.779731] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[232.882724] [064/132] (800s left) kms_chamelium_color (ctm-blue-to-red)
[233.345940] Subtest ctm-blue-to-red: SKIP (0.000s)
[233.414817] [065/132] (799s left) core_setmaster (master-drop-set-user)
[233.543834] Starting subtest: master-drop-set-user
[233.565520] Subtest master-drop-set-user: SUCCESS (0.022s)
[233.613983] [066/132] (799s left) syncobj_wait (wait-all-complex)
[233.670816] Starting subtest: wait-all-complex
[233.884044] Subtest wait-all-complex: SUCCESS (0.214s)
[233.981504] [067/132] (799s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[234.038929] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[234.040295] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[234.131449] [068/132] (799s left) gem_exec_parallel (userptr)
[234.197998] Starting subtest: userptr
[234.198729] Starting dynamic subtest: rcs0
[235.921072] Dynamic subtest rcs0: SUCCESS (1.722s)
[235.936448] Starting dynamic subtest: bcs0
[239.944174] Dynamic subtest bcs0: SUCCESS (4.022s)
[239.944933] Subtest userptr: SUCCESS (5.747s)
[240.142492] [069/132] (793s left) kms_pm_rpm (pm-tiling)
[251.881376] Subtest pm-tiling: SKIP (0.000s)
[251.941633] [070/132] (781s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[252.418163] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[252.478190] [071/132] (780s left) kms_psr (psr2-cursor-mmap-gtt)
[252.953488] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[253.012906] [072/132] (780s left) i915_pm_rps (waitboost)
[253.077806] Starting subtest: waitboost
[256.610968] Subtest waitboost: SUCCESS (3.533s)
[256.712139] [073/132] (776s left) gem_ctx_persistence (hang)
[256.776750] Subtest hang: SKIP (0.000s)
[256.840161] [074/132] (776s left) kms_psr (fbc-psr2-sprite-blt)
[257.313949] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[257.373483] [075/132] (776s left) kms_lease (empty-lease)
[257.851548] Starting subtest: empty-lease
[257.852628] Starting dynamic subtest: pipe-A-VGA-1
[257.854564] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.001s)
[257.867477] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.868150] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[257.878966] Starting dynamic subtest: pipe-B-VGA-1
[257.879697] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[257.891304] Starting dynamic subtest: pipe-B-HDMI-A-1
[257.892453] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[257.893415] Subtest empty-lease: SUCCESS (0.013s)
[257.965144] [076/132] (775s left) syncobj_wait (wait-all-for-submit-complex)
[258.024486] Starting subtest: wait-all-for-submit-complex
[258.240826] Subtest wait-all-for-submit-complex: SUCCESS (0.216s)
[258.336748] [077/132] (775s left) api_intel_bb (reset-bb)
[258.391911] Starting subtest: reset-bb
[258.392516] Subtest reset-bb: SUCCESS (0.001s)
[258.520791] [078/132] (775s left) kms_chamelium_hpd (hdmi-hpd-storm)
[259.103101] Subtest hdmi-hpd-storm: SKIP (0.000s)
[259.335701] [079/132] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[259.826114] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[259.827541] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[259.936769] [080/132] (773s left) gem_exec_schedule (u-submit-late-slice)
[260.004886] Subtest u-submit-late-slice: SKIP (0.000s)
[260.204144] [081/132] (773s left) kms_invalid_mode (int-max-clock)
[260.680965] Starting subtest: int-max-clock
[260.682150] Starting dynamic subtest: pipe-A-VGA-1
[260.802520] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.121s)
[260.817635] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.818408] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[260.830649] Starting dynamic subtest: pipe-B-VGA-1
[260.831191] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[260.841899] Starting dynamic subtest: pipe-B-HDMI-A-1
[260.842588] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[260.843120] Subtest int-max-clock: SUCCESS (0.130s)
[261.064492] [082/132] (772s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[261.122582] Subtest enable-vfs-bind-unbind-each-numvfs-all: SKIP (0.000s)
[261.188317] [083/132] (772s left) gem_exec_suspend (basic-s3)
[261.260572] Starting subtest: basic-S3
[261.261396] Starting dynamic subtest: smem
[280.008629] Dynamic subtest smem: SUCCESS (2.354s)
[280.009236] Subtest basic-S3: SUCCESS (2.356s)
[287.070300] [084/132] (753s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[289.647578] Starting subtest: verify-pxp-key-change-after-suspend-resume
[289.648925] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[289.747262] [085/132] (751s left) gem_exec_schedule (pi-common)
[289.820268] Subtest pi-common: SKIP (0.000s)
[290.013974] [086/132] (751s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[290.499759] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[290.501037] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[290.614118] [087/132] (750s left) gem_exec_balancer (parallel-contexts)
[290.675730] Subtest parallel-contexts: SKIP (0.000s)
[290.776147] [088/132] (750s left) i915_hangman (gt-engine-error)
[290.841100] Starting subtest: gt-engine-error
[290.842325] Subtest gt-engine-error: SKIP (0.000s)
[290.910559] [089/132] (750s left) kms_cursor_crc (cursor-random-512x512)
[291.397563] Starting subtest: cursor-random-512x512
[291.399572] Subtest cursor-random-512x512: SKIP (0.001s)
[291.517380] [090/132] (749s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[291.991745] Starting subtest: fb-8bpc-vs-panel-6bpc
[291.993249] Starting dynamic subtest: pipe-A-HDMI-A-1
[292.108672] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.116s)
[292.109679] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.118s)
[292.402430] [091/132] (749s left) perf_pmu (busy-start)
[292.464555] Starting subtest: busy-start
[292.465166] Starting dynamic subtest: rcs0
[294.983286] Dynamic subtest rcs0: SUCCESS (2.520s)
[295.000606] Starting dynamic subtest: bcs0
[297.502368] Dynamic subtest bcs0: SUCCESS (2.518s)
[297.522688] Starting dynamic subtest: vcs0
[300.519275] Dynamic subtest vcs0: SUCCESS (3.016s)
[300.521977] Subtest busy-start: SUCCESS (8.063s)
[300.629528] [092/132] (740s left) gem_fence_thrash (bo-write-verify-threaded-x)
[300.686273] Starting subtest: bo-write-verify-threaded-x
[302.473360] Subtest bo-write-verify-threaded-x: SUCCESS (1.787s)
[302.594162] [093/132] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[303.080611] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[303.082182] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[303.203345] [094/132] (738s left) kms_flip (2x-plain-flip-interruptible)
[303.686827] Starting subtest: 2x-plain-flip-interruptible
[303.688860] Starting dynamic subtest: AB-VGA1-HDMI-A1
[306.069907] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.381s)
[306.073225] Subtest 2x-plain-flip-interruptible: SUCCESS (2.386s)
[306.345585] [095/132] (735s left) gem_exec_reloc (basic-cpu-wc-active)
[306.405609] Starting subtest: basic-cpu-wc-active
[306.515401] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[307.028511] [096/132] (734s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[307.088214] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[307.154951] [097/132] (734s left) kms_vrr (lobf)
[307.630503] Starting subtest: lobf
[307.631815] Subtest lobf: SKIP (0.000s)
[307.725412] [098/132] (734s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[308.207008] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[308.208113] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[308.326690] [099/132] (733s left) kms_busy (extended-modeset-hang-oldfb)
[308.807493] Starting subtest: extended-modeset-hang-oldfb
[308.810555] Starting dynamic subtest: pipe-A
[314.696077] Dynamic subtest pipe-A: SUCCESS (5.888s)
[314.711645] Starting dynamic subtest: pipe-B
[320.793454] Dynamic subtest pipe-B: SUCCESS (6.095s)
[320.798422] Subtest extended-modeset-hang-oldfb: SUCCESS (11.988s)
[321.078369] [100/132] (720s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[321.149920] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[321.151505] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[321.357753] [101/132] (720s left) sw_sync (sync_multi_producer_single_consumer)
[321.415513] Starting subtest: sync_multi_producer_single_consumer
[322.491620] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[322.573483] [102/132] (719s left) kms_content_protection (dp-mst-type-1)
[323.070644] Starting subtest: dp-mst-type-1
[323.071826] Subtest dp-mst-type-1: SKIP (0.000s)
[323.187497] [103/132] (718s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[323.675947] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[325.597370] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.923s)
[325.859486] [104/132] (716s left) gem_ctx_isolation (preservation-reset)
[326.040417] Starting subtest: preservation-reset
[326.041214] Starting dynamic subtest: rcs0
[326.538612] Dynamic subtest rcs0: SUCCESS (0.498s)
[326.542770] Subtest preservation-reset: SUCCESS (0.501s)
[326.672449] [105/132] (715s left) gem_userptr_blits (probe)
[326.761127] Starting subtest: probe
[326.953016] Subtest probe: SUCCESS (0.193s)
[327.069707] [106/132] (715s left) kms_rotation_crc (exhaust-fences)
[327.544051] Starting subtest: exhaust-fences
[327.545238] Subtest exhaust-fences: SKIP (0.000s)
[327.642807] [107/132] (714s left) kms_feature_discovery (display-4x)
[328.120559] Starting subtest: display-4x
[328.122854] Subtest display-4x: SKIP (0.000s)
[328.226247] [108/132] (714s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[328.705137] Starting subtest: psr-farfromfence-mmap-gtt
[328.706328] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[328.827210] [109/132] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[329.306138] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[329.307114] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[329.414599] [110/132] (713s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[329.896570] Starting subtest: y-tiled-64bpp-rotate-0
[329.898047] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[330.013717] [111/132] (712s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[330.489347] Starting subtest: cursorA-vs-flipB-legacy
[341.439387] Subtest cursorA-vs-flipB-legacy: SUCCESS (10.950s)
[341.703791] [112/132] (700s left) kms_pm_lpsp (screens-disabled)
[353.229660] Starting subtest: screens-disabled
[353.492687] Subtest screens-disabled: SKIP (0.262s)
[353.742388] [113/132] (688s left) syncobj_wait (reset-signaled)
[353.803945] Starting subtest: reset-signaled
[353.804562] Subtest reset-signaled: SUCCESS (0.000s)
[353.907257] [114/132] (688s left) i915_drm_fdinfo (memory-info-resident)
[353.964171] Subtest memory-info-resident: SKIP (0.000s)
[354.031406] [115/132] (688s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[354.091055] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[354.091646] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[354.190745] [116/132] (688s left) i915_pm_rpm (gem-evict-pwrite)
[365.956586] Subtest gem-evict-pwrite: SKIP (0.000s)
[366.026578] [117/132] (676s left) gem_eio (in-flight-internal-immediate)
[366.090068] Starting subtest: in-flight-internal-immediate
[366.124601] Subtest in-flight-internal-immediate: SUCCESS (0.034s)
[366.654449] [118/132] (676s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[366.712942] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[366.774588] [119/132] (676s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[366.829327] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[366.901990] [120/132] (676s left) vgem_basic (dmabuf-mmap)
[366.975119] Starting subtest: dmabuf-mmap
[367.002717] Subtest dmabuf-mmap: SUCCESS (0.029s)
[367.090237] [121/132] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[367.571710] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[367.572883] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[367.700596] [122/132] (675s left) gem_exec_async (forked-writes)
[367.769680] Starting subtest: forked-writes
[367.770726] Starting dynamic subtest: rcs0
[367.788214] Dynamic subtest rcs0: SUCCESS (0.017s)
[367.807876] Starting dynamic subtest: bcs0
[367.813290] Dynamic subtest bcs0: SUCCESS (0.020s)
[367.832040] Starting dynamic subtest: vcs0
[367.842321] Dynamic subtest vcs0: SUCCESS (0.030s)
[367.844544] Subtest forked-writes: SUCCESS (0.074s)
[368.076412] [123/132] (675s left) gem_exec_alignment (single)
[368.140800] Starting subtest: single
[368.142692] Subtest single: SUCCESS (0.003s)
[368.260536] [124/132] (674s left) api_intel_allocator (reserve-simple)
[368.322422] Starting subtest: reserve-simple
[368.328468] Subtest reserve-simple: SUCCESS (0.007s)
[368.444583] [125/132] (674s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[368.504245] Starting subtest: multi-wait-for-submit-available-signaled
[368.506079] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[368.612456] [126/132] (674s left) gen7_exec_parse (batch-without-end)
[368.677622] Subtest batch-without-end: SKIP (0.000s)
[368.741417] [127/132] (674s left) kms_vblank (wait-forked-busy-hang)
[369.214552] Starting subtest: wait-forked-busy-hang
[369.215566] Starting dynamic subtest: pipe-A-VGA-1
[375.532844] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.319s)
[375.556017] Starting dynamic subtest: pipe-A-HDMI-A-1
[381.570327] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.036s)
[381.592205] Starting dynamic subtest: pipe-B-VGA-1
[387.571102] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.996s)
[387.588197] Starting dynamic subtest: pipe-B-HDMI-A-1
[393.607802] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.033s)
[393.610391] Subtest wait-forked-busy-hang: SUCCESS (24.397s)
[393.890232] [128/132] (649s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[394.374253] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[394.468210] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.093s)
[394.709090] [129/132] (648s left) gen3_render_mixed_blits
[394.837764] [130/132] (648s left) kms_psr (fbc-pr-primary-mmap-gtt)
[395.310781] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[395.371572] [131/132] (648s left) kms_cursor_crc (cursor-suspend)
[395.851263] Starting subtest: cursor-suspend
[395.854026] Starting dynamic subtest: pipe-A-VGA-1
[433.088386] Dynamic subtest pipe-A-VGA-1: SUCCESS (4.557s)
[433.104797] Starting dynamic subtest: pipe-B-HDMI-A-1
[469.101403] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.528s)
[469.105247] Subtest cursor-suspend: SUCCESS (10.091s)
[476.189594] [132/132] (574s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[476.678480] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[477.853262] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.183s)
[478.107509] 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.