[73.969881] Initializing watchdogs
[73.970092]   /dev/watchdog0
[73.989578] [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)
[73.997308] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.001134] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.004179] [001/132] (960s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[74.095399] Starting subtest: invalid-single-wait-all-unsubmitted
[74.096086] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[74.222295] [002/132] (960s left) kms_cursor_crc (cursor-sliding-64x21)
[74.736398] Starting subtest: cursor-sliding-64x21
[74.796870] Subtest cursor-sliding-64x21: SKIP (0.059s)
[75.399281] [003/132] (959s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[75.897466] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[75.898352] Starting dynamic subtest: pipe-A
[75.900540] Dynamic subtest pipe-A: SKIP (0.001s)
[75.909260] Starting dynamic subtest: pipe-B
[75.911208] Dynamic subtest pipe-B: SKIP (0.001s)
[75.912433] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SKIP (0.003s)
[76.500534] [004/132] (958s left) sysfs_preempt_timeout (timeout)
[76.567970] Starting subtest: timeout
[76.568860] Starting dynamic subtest: vcs0
[76.570133] Dynamic subtest vcs0: SKIP (0.000s)
[76.579724] Starting dynamic subtest: bcs0
[76.581582] Dynamic subtest bcs0: SKIP (0.000s)
[76.593475] Starting dynamic subtest: rcs0
[76.595379] Dynamic subtest rcs0: SKIP (0.000s)
[76.597073] Subtest timeout: SKIP (0.002s)
[76.695963] [005/132] (957s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[76.752242] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[76.807921] [006/132] (957s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[76.861228] Starting subtest: etime-multi-wait-all-available-unsubmitted
[76.963145] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[77.085157] [007/132] (957s left) perf (gen8-unprivileged-single-ctx-counters)
[77.227709] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[77.276073] [008/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[77.778861] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[77.782332] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[78.381172] [009/132] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[78.888982] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[78.890380] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[79.493959] [010/132] (955s left) kms_flip (basic-flip-vs-dpms)
[79.991700] Starting subtest: basic-flip-vs-dpms
[79.992494] Starting dynamic subtest: A-VGA1
[80.810411] Dynamic subtest A-VGA1: SUCCESS (0.818s)
[80.820863] Starting dynamic subtest: B-VGA1
[81.501102] Dynamic subtest B-VGA1: SUCCESS (0.690s)
[81.509913] Starting dynamic subtest: A-HDMI-A1
[82.273782] Dynamic subtest A-HDMI-A1: SUCCESS (0.772s)
[82.282612] Starting dynamic subtest: B-HDMI-A1
[83.080405] Dynamic subtest B-HDMI-A1: SUCCESS (0.805s)
[83.081176] Subtest basic-flip-vs-dpms: SUCCESS (3.089s)
[83.826123] [011/132] (951s left) syncobj_timeline (invalid-transfer-non-existent-point)
[83.898356] Starting subtest: invalid-transfer-non-existent-point
[83.899187] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[84.032942] [012/132] (950s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[84.528960] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[86.153606] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.624s)
[86.794799] [013/132] (948s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[86.860984] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[86.918239] [014/132] (948s left) gem_bad_reloc (negative-reloc)
[86.976642] Starting subtest: negative-reloc
[86.978242] Subtest negative-reloc: SKIP (0.000s)
[87.109952] [015/132] (948s left) kms_hdr (bpc-switch-dpms)
[87.608920] Starting subtest: bpc-switch-dpms
[93.462838] Subtest bpc-switch-dpms: SKIP (5.850s)
[94.233451] [016/132] (940s left) gem_pread (uncached)
[94.306253] Starting subtest: uncached
[95.663273] Subtest uncached: SUCCESS (1.356s)
[95.800729] [017/132] (939s left) kms_psr2_su (frontbuffer-xrgb8888)
[95.852875] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[95.913991] [018/132] (939s left) gem_exec_params (invalid-bsd2-flag-on-render)
[95.972373] Starting subtest: invalid-bsd2-flag-on-render
[95.973050] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[96.104393] [019/132] (939s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[96.594391] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[96.595900] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[97.198990] [020/132] (938s left) gem_exec_async (concurrent-writes)
[97.261400] Starting subtest: concurrent-writes
[97.262224] Starting dynamic subtest: rcs0
[97.264412] Dynamic subtest rcs0: SUCCESS (0.003s)
[97.276861] Starting dynamic subtest: bcs0
[97.277660] Dynamic subtest bcs0: SUCCESS (0.002s)
[97.286538] Starting dynamic subtest: vcs0
[97.287240] Dynamic subtest vcs0: SUCCESS (0.003s)
[97.287923] Subtest concurrent-writes: SUCCESS (0.010s)
[97.516058] [021/132] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[98.015662] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[98.018323] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[98.620318] [022/132] (936s left) kms_pm_dc (dc5-psr)
[109.720142] Subtest dc5-psr: SKIP (0.000s)
[109.783577] [023/132] (925s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[110.275135] Starting subtest: fb-8bpc-vs-panel-8bpc
[110.277747] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.368412] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.090s)
[110.369900] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.092s)
[111.059787] [024/132] (924s left) kms_flip (blocking-absolute-wf_vblank)
[111.558131] Starting subtest: blocking-absolute-wf_vblank
[111.559890] Starting dynamic subtest: A-VGA1
[119.351473] Dynamic subtest A-VGA1: SUCCESS (7.790s)
[119.362468] Starting dynamic subtest: B-VGA1
[127.074915] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[127.086018] Starting dynamic subtest: A-HDMI-A1
[134.814231] Dynamic subtest A-HDMI-A1: SUCCESS (7.736s)
[134.826311] Starting dynamic subtest: B-HDMI-A1
[142.587221] Dynamic subtest B-HDMI-A1: SUCCESS (7.770s)
[142.588016] Subtest blocking-absolute-wf_vblank: SUCCESS (31.027s)
[143.371711] [025/132] (892s left) gem_exec_fence (long-history)
[143.606173] Starting subtest: long-history
[143.680494] Subtest long-history: SUCCESS (0.074s)
[144.024106] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[144.026907] [026/132] (891s left) kms_big_fb (linear-64bpp-rotate-90)
[144.526709] Starting subtest: linear-64bpp-rotate-90
[144.546089] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[145.159539] [027/132] (890s left) kms_async_flips (async-flip-hang)
[145.652842] Starting subtest: async-flip-hang
[145.784092] Starting dynamic subtest: pipe-A-HDMI-A-1
[152.884053] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.100s)
[153.021493] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.858780] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.845s)
[159.859895] Subtest async-flip-hang: SUCCESS (14.208s)
[160.685459] [028/132] (875s left) kms_lease (lease-unleased-crtc)
[161.178922] Starting subtest: lease-unleased-crtc
[161.179974] Starting dynamic subtest: pipe-A-HDMI-A-1
[161.290781] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.112s)
[161.301913] Starting dynamic subtest: pipe-B-HDMI-A-1
[161.325696] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.032s)
[161.326563] Subtest lease-unleased-crtc: SUCCESS (0.148s)
[162.037441] [029/132] (873s left) kms_setmode (invalid-clone-single-crtc)
[162.093183] Starting subtest: invalid-clone-single-crtc
[162.095009] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[162.217926] [030/132] (873s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[162.697471] Starting subtest: primary-yf-tiled-reflect-x-270
[162.698921] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[163.305413] [031/132] (872s left) gem_lmem_swapping (verify-ccs)
[163.367784] Subtest verify-ccs: SKIP (0.000s)
[163.429747] [032/132] (872s left) gem_mmap_gtt (basic-small-bo-tiledx)
[163.484657] Starting subtest: basic-small-bo-tiledX
[164.086667] Subtest basic-small-bo-tiledX: SUCCESS (0.601s)
[164.250844] [033/132] (871s left) kms_psr (fbc-pr-sprite-blt)
[164.860167] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[165.163953] [034/132] (870s left) gem_ctx_param (invalid-get-no-zeromap)
[165.225974] Starting subtest: invalid-get-no-zeromap
[165.226862] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[165.352431] [035/132] (870s left) gem_exec_params (rsvd2-dirt)
[165.410435] Starting subtest: rsvd2-dirt
[165.412456] Subtest rsvd2-dirt: SKIP (0.000s)
[165.563044] [036/132] (870s left) kms_chamelium_audio (dp-audio-edid)
[166.127059] Subtest dp-audio-edid: SKIP (0.000s)
[166.527980] [037/132] (869s left) gem_userptr_blits (stress-mm-invalidate-close)
[166.602678] Starting subtest: stress-mm-invalidate-close
[168.751786] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[168.916119] [038/132] (867s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[168.975299] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[169.043858] [039/132] (867s left) i915_drm_fdinfo (virtual-busy-all)
[169.103108] Subtest virtual-busy-all: SKIP (0.000s)
[169.163111] [040/132] (867s left) kms_plane (plane-panning-bottom-right)
[169.651613] Starting subtest: plane-panning-bottom-right
[169.652377] Starting dynamic subtest: pipe-A
[170.247834] Dynamic subtest pipe-A: SUCCESS (0.595s)
[170.259295] Starting dynamic subtest: pipe-B
[170.856388] Dynamic subtest pipe-B: SUCCESS (0.607s)
[170.857147] Subtest plane-panning-bottom-right: SUCCESS (1.206s)
[171.554486] [041/132] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[172.046775] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[172.048131] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[172.652036] [042/132] (863s left) kms_atomic (atomic-plane-damage)
[173.139738] Starting subtest: atomic-plane-damage
[173.467333] Subtest atomic-plane-damage: SKIP (0.327s)
[174.279604] [043/132] (862s left) kms_flip (modeset-vs-vblank-race)
[174.772456] Starting subtest: modeset-vs-vblank-race
[174.773248] Starting dynamic subtest: A-VGA1
[177.937859] Dynamic subtest A-VGA1: SUCCESS (3.164s)
[177.951250] Starting dynamic subtest: B-VGA1
[181.009618] Dynamic subtest B-VGA1: SUCCESS (3.068s)
[181.023129] Starting dynamic subtest: A-HDMI-A1
[184.147517] Dynamic subtest A-HDMI-A1: SUCCESS (3.134s)
[184.160127] Starting dynamic subtest: B-HDMI-A1
[187.312203] Dynamic subtest B-HDMI-A1: SUCCESS (3.161s)
[187.315961] Subtest modeset-vs-vblank-race: SUCCESS (12.543s)
[188.106263] [044/132] (848s left) kms_psr (pr-cursor-plane-move)
[188.631739] Subtest pr-cursor-plane-move: SKIP (0.000s)
[188.934630] [045/132] (847s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[188.991178] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[189.053832] [046/132] (847s left) i915_pm_rpm (debugfs-read)
[200.831909] Subtest debugfs-read: SKIP (0.000s)
[201.131577] [047/132] (835s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[201.207236] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[201.208099] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[201.340516] [048/132] (835s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[201.399237] Starting subtest: single-wait-for-submit-unsubmitted
[201.507048] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[201.638575] [049/132] (835s left) kms_concurrent (multi-plane-atomic-lowres)
[202.125885] Starting subtest: multi-plane-atomic-lowres
[202.126753] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.615958] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.489s)
[202.617090] Subtest multi-plane-atomic-lowres: SUCCESS (0.492s)
[203.312327] [050/132] (833s left) gem_mmap_gtt (basic-write-read-distinct)
[203.372456] Starting subtest: basic-write-read-distinct
[203.387582] Subtest basic-write-read-distinct: SUCCESS (0.015s)
[203.525068] [051/132] (833s left) kms_big_fb (4-tiled-addfb-size-overflow)
[204.022561] Starting subtest: 4-tiled-addfb-size-overflow
[204.024015] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[204.625206] [052/132] (832s left) gem_render_copy (linear-to-vebox-yf-tiled)
[204.695605] Starting subtest: linear-to-vebox-yf-tiled
[204.697854] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[204.928671] [053/132] (832s left) gem_mmap (basic-small-bo)
[204.987225] Starting subtest: basic-small-bo
[205.403957] Subtest basic-small-bo: SUCCESS (0.417s)
[205.542726] [054/132] (831s left) gem_exec_flush (basic-wb-rw-before-default)
[205.721408] Starting subtest: basic-wb-rw-before-default
[211.161131] Subtest basic-wb-rw-before-default: SUCCESS (5.440s)
[211.396994] [055/132] (825s left) kms_flip (2x-flip-vs-suspend-interruptible)
[211.897515] Starting subtest: 2x-flip-vs-suspend-interruptible
[211.899813] Starting dynamic subtest: AB-VGA1-HDMI-A1
[415.828484] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[426.678589] Closing watchdogs
[426.684055] Initializing watchdogs
[426.684132]   /dev/watchdog0
[426.707175] [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)
[426.724272] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[426.725936] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[426.726705] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[426.731173] [056/132] (620s left) kms_cursor_crc (cursor-offscreen-512x512)
[427.283974] Starting subtest: cursor-offscreen-512x512
[427.287135] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[427.908385] [057/132] (619s left) kms_frontbuffer_tracking (fbc-tiling-4)
[428.403793] Starting subtest: fbc-tiling-4
[428.405253] Subtest fbc-tiling-4: SKIP (0.000s)
[429.010452] [058/132] (618s left) i915_pciid
[429.189596] [059/132] (618s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[429.678266] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[429.679615] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[430.287665] [060/132] (617s left) gem_exec_schedule (submit-early-slice)
[430.370815] Subtest submit-early-slice: SKIP (0.000s)
[430.616782] [061/132] (616s left) perf_pmu (busy-double-start)
[430.681791] Starting subtest: busy-double-start
[430.682601] Starting dynamic subtest: rcs0
[434.211712] Dynamic subtest rcs0: SUCCESS (3.529s)
[434.229750] Starting dynamic subtest: bcs0
[437.736642] Dynamic subtest bcs0: SUCCESS (3.523s)
[437.754991] Starting dynamic subtest: vcs0
[441.751815] Dynamic subtest vcs0: SUCCESS (4.012s)
[441.753645] Subtest busy-double-start: SUCCESS (11.071s)
[441.895519] [062/132] (605s left) gem_mmap_gtt (big-bo-tiledx)
[441.951900] Starting subtest: big-bo-tiledX
[442.324312] Subtest big-bo-tiledX: SUCCESS (0.372s)
[442.499947] [063/132] (605s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[443.107875] Starting subtest: cursor-vs-flip-varying-size
[477.621579] Subtest cursor-vs-flip-varying-size: SUCCESS (34.518s)
[478.336981] [064/132] (569s left) kms_properties (colorop-properties-legacy)
[478.838008] Starting subtest: colorop-properties-legacy
[478.838981] Starting dynamic subtest: pipe-A-HDMI-A-1
[478.967109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.128s)
[478.982838] Starting dynamic subtest: pipe-B-HDMI-A-1
[479.191028] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.221s)
[479.191905] Subtest colorop-properties-legacy: SUCCESS (0.354s)
[479.917389] [065/132] (567s left) gem_exec_params (larger-than-life-batch)
[479.983156] Starting subtest: larger-than-life-batch
[479.984841] Subtest larger-than-life-batch: SKIP (0.000s)
[480.122391] [066/132] (567s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[480.606908] Starting subtest: 2x-flip-vs-cursor-atomic
[480.608428] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[481.225214] [067/132] (566s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[481.719610] Starting subtest: 2x-absolute-wf_vblank-interruptible
[481.721864] Starting dynamic subtest: AB-VGA1-HDMI-A1
[512.130067] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.407s)
[512.132820] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (30.412s)
[512.935894] [068/132] (534s left) gem_mmap_gtt (basic-read-write-distinct)
[513.017568] Starting subtest: basic-read-write-distinct
[513.032450] Subtest basic-read-write-distinct: SUCCESS (0.015s)
[513.183640] [069/132] (534s left) kms_pm_rpm (fences)
[524.971449] Subtest fences: SKIP (0.000s)
[525.292771] [070/132] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[525.789481] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[525.790825] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[526.397869] [071/132] (521s left) kms_busy (basic)
[526.891243] Starting subtest: basic
[526.892335] Starting dynamic subtest: flip
[527.317570] Dynamic subtest flip: SUCCESS (0.424s)
[527.331840] Starting dynamic subtest: modeset
[528.103847] Dynamic subtest modeset: SUCCESS (0.785s)
[528.104571] Subtest basic: SUCCESS (1.214s)
[528.819600] [072/132] (519s left) kms_universal_plane (universal-plane-sanity)
[529.312747] Starting subtest: universal-plane-sanity
[529.314010] Starting dynamic subtest: pipe-A-HDMI-A-1
[529.556811] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.242s)
[529.573102] Starting dynamic subtest: pipe-B-HDMI-A-1
[529.842916] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.284s)
[529.843794] Subtest universal-plane-sanity: SUCCESS (0.532s)
[530.550383] [073/132] (517s left) kms_selftest (drm_dp_mst_helper)
[530.619970] Starting subtest: drm_dp_mst_helper
[530.634139] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[530.734129] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.098s)
[530.754167] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[530.826738] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.091s)
[530.841908] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[530.927578] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s)
[530.928706] Subtest drm_dp_mst_helper: SUCCESS (0.307s)
[531.117764] [074/132] (517s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[531.176583] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[531.241953] [075/132] (517s left) gem_exec_reloc (basic-cpu-gtt-active)
[531.298988] Starting subtest: basic-cpu-gtt-active
[531.410032] Subtest basic-cpu-gtt-active: SUCCESS (0.110s)
[532.450984] [076/132] (515s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[532.513311] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[532.619233] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.106s)
[532.750444] [077/132] (515s left) gem_userptr_blits (invalid-null-pointer)
[532.806828] Starting subtest: invalid-null-pointer
[532.808963] Subtest invalid-null-pointer: SUCCESS (0.001s)
[532.998430] [078/132] (515s left) gem_exec_balancer (full-late-pulse)
[533.059926] Subtest full-late-pulse: SKIP (0.000s)
[533.201480] [079/132] (515s left) kms_chamelium_frames (dp-crc-single)
[533.765648] Subtest dp-crc-single: SKIP (0.000s)
[534.164870] [080/132] (514s left) perf_pmu (semaphore-wait-idle)
[534.227562] Starting subtest: semaphore-wait-idle
[534.228368] Starting dynamic subtest: rcs0
[534.229801] Dynamic subtest rcs0: SKIP (0.001s)
[534.248323] Starting dynamic subtest: bcs0
[534.250189] Dynamic subtest bcs0: SKIP (0.000s)
[534.274791] Starting dynamic subtest: vcs0
[534.276883] Dynamic subtest vcs0: SKIP (0.000s)
[534.279031] Subtest semaphore-wait-idle: SKIP (0.006s)
[534.382899] [081/132] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[534.873268] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[534.874616] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[535.481790] [082/132] (513s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[535.539615] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[535.643185] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[535.781537] [083/132] (512s left) prime_self_import (basic-with_one_bo)
[535.836340] Starting subtest: basic-with_one_bo
[535.838803] Subtest basic-with_one_bo: SUCCESS (0.003s)
[535.980765] [084/132] (512s left) gem_ppgtt (blt-vs-render-ctxn)
[536.039566] Starting subtest: blt-vs-render-ctxN
[568.677928] Subtest blt-vs-render-ctxN: SUCCESS (32.636s)
[568.830983] [085/132] (480s left) syncobj_wait (single-wait-all-submitted)
[569.003875] Starting subtest: single-wait-all-submitted
[569.106643] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[569.225822] [086/132] (479s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[569.716883] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[569.718394] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.002s)
[570.339164] [087/132] (478s left) kms_psr (psr-sprite-mmap-cpu)
[570.823060] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[571.133973] [088/132] (477s left) perf (non-sampling-read-error)
[571.337996] Subtest non-sampling-read-error: SKIP (0.000s)
[571.393883] [089/132] (477s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[571.887082] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[571.888470] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[572.500769] [090/132] (476s left) gem_watchdog (default-physical)
[572.566611] Starting subtest: default-physical
[572.569530] Subtest default-physical: SKIP (0.002s)
[572.680654] [091/132] (476s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[573.166835] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[573.169012] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[573.783775] [092/132] (475s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[574.287635] Starting subtest: x-tiled-addfb-size-offset-overflow
[574.289089] Subtest x-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[574.887595] [093/132] (474s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[575.379009] Starting subtest: yf-tiled-16bpp-rotate-0
[575.381144] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[575.983742] [094/132] (473s left) kms_cursor_crc (cursor-offscreen-128x128)
[576.493617] Starting subtest: cursor-offscreen-128x128
[576.496183] Starting dynamic subtest: pipe-A-HDMI-A-1
[578.949792] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.454s)
[578.992423] Starting dynamic subtest: pipe-B-HDMI-A-1
[581.378563] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.401s)
[581.379496] Subtest cursor-offscreen-128x128: SUCCESS (4.886s)
[582.089155] [095/132] (467s left) kms_psr (psr2-basic)
[582.577395] Subtest psr2-basic: SKIP (0.000s)
[582.884916] [096/132] (466s left) gem_exec_whisper (basic-fds-priority)
[582.958012] Starting subtest: basic-fds-priority
[582.959595] Subtest basic-fds-priority: SKIP (0.001s)
[583.206856] [097/132] (466s left) syncobj_timeline (wait-all-interrupted)
[583.262789] Starting subtest: wait-all-interrupted
[583.366379] Subtest wait-all-interrupted: SUCCESS (0.102s)
[583.503315] [098/132] (466s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[583.994111] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[583.995635] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[584.621601] [099/132] (465s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[585.189719] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[585.586723] [100/132] (464s left) drm_read (short-buffer-wakeup)
[586.122041] Starting subtest: short-buffer-wakeup
[618.338917] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[618.976368] [101/132] (430s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[619.469271] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[621.388369] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.918s)
[622.033702] [102/132] (427s left) gem_ctx_persistence (legacy-engines-mixed-process)
[622.092365] Subtest legacy-engines-mixed-process: SKIP (0.000s)
[622.156597] [103/132] (427s left) gem_mmap_wc (write-read-distinct)
[622.215186] Starting subtest: write-read-distinct
[622.229537] Subtest write-read-distinct: SUCCESS (0.014s)
[622.374815] [104/132] (427s left) gem_ctx_engines (none)
[622.440312] Starting subtest: none
[622.442417] Subtest none: SUCCESS (0.001s)
[622.677907] [105/132] (427s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[623.171957] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[623.174149] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[623.797478] [106/132] (426s left) gem_exec_params (rel-constants-invalid-ring)
[623.862759] Starting subtest: rel-constants-invalid-ring
[623.863502] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[624.009847] [107/132] (426s left) gem_mmap_offset (bad-extensions)
[624.065462] Starting subtest: bad-extensions
[624.066188] Subtest bad-extensions: SUCCESS (0.000s)
[624.225383] [108/132] (425s left) gem_huc_copy (huc-copy)
[624.283640] Subtest huc-copy: SKIP (0.000s)
[624.352623] [109/132] (425s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[624.839835] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[624.841121] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[625.460871] [110/132] (424s left) i915_suspend (fence-restore-tiled2untiled)
[625.518135] Starting subtest: fence-restore-tiled2untiled
[643.391887] Subtest fence-restore-tiled2untiled: SUCCESS (1.708s)
[652.549269] [111/132] (406s left) kms_atomic_interruptible (legacy-cursor)
[653.051388] Starting subtest: legacy-cursor
[653.054197] Starting dynamic subtest: pipe-A-HDMI-A-1
[659.374749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.319s)
[659.375473] Subtest legacy-cursor: SUCCESS (6.322s)
[660.083166] [112/132] (399s left) kms_plane_lowres (tiling-4)
[660.584331] Starting subtest: tiling-4
[660.585946] Subtest tiling-4: SKIP (0.000s)
[661.183760] [113/132] (398s left) api_intel_allocator (standalone)
[661.245402] Starting subtest: standalone
[661.271781] Subtest standalone: SUCCESS (0.027s)
[661.419582] [114/132] (398s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[661.906705] Starting subtest: cursor-rapid-movement-128x128
[661.909773] Starting dynamic subtest: pipe-A-HDMI-A-1
[662.251090] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.341s)
[662.294877] Starting dynamic subtest: pipe-B-HDMI-A-1
[662.645869] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.367s)
[662.646543] Subtest cursor-rapid-movement-128x128: SUCCESS (0.740s)
[663.354609] [115/132] (396s left) kms_invalid_mode (overflow-vrefresh)
[663.845541] Starting subtest: overflow-vrefresh
[663.846413] Starting dynamic subtest: pipe-A-HDMI-A-1
[663.922474] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.075s)
[663.937794] Starting dynamic subtest: pipe-B-HDMI-A-1
[663.938524] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[663.939248] Subtest overflow-vrefresh: SUCCESS (0.080s)
[664.637827] [116/132] (395s left) syncobj_timeline (reset-multiple-signaled)
[664.697401] Starting subtest: reset-multiple-signaled
[664.699421] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[664.838845] [117/132] (394s left) api_intel_bb (object-reloc-keep-cache)
[664.893908] Starting subtest: object-reloc-keep-cache
[664.895869] Subtest object-reloc-keep-cache: SUCCESS (0.003s)
[665.055689] [118/132] (394s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[665.549594] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[665.849811] [119/132] (393s left) gen9_exec_parse (basic-rejected)
[665.910867] Subtest basic-rejected: SKIP (0.000s)
[665.986582] [120/132] (393s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[666.471764] Starting subtest: flip-vs-cursor-atomic-transitions
[677.220257] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (10.747s)
[677.931738] [121/132] (382s left) kms_vblank (wait-idle)
[678.418686] Starting subtest: wait-idle
[678.419575] Starting dynamic subtest: pipe-A-HDMI-A-1
[680.630193] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.210s)
[680.647480] Starting dynamic subtest: pipe-B-HDMI-A-1
[682.880905] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.248s)
[682.881912] Subtest wait-idle: SUCCESS (4.463s)
[683.582937] [122/132] (376s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[684.077994] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[684.079361] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[684.701590] [123/132] (375s left) gem_spin_batch (resubmit-new)
[684.769199] Starting subtest: resubmit-new
[684.770018] Starting dynamic subtest: rcs0
[684.772333] Dynamic subtest rcs0: SUCCESS (0.003s)
[684.788628] Starting dynamic subtest: bcs0
[684.789505] Dynamic subtest bcs0: SUCCESS (0.001s)
[684.803771] Starting dynamic subtest: vcs0
[684.804594] Dynamic subtest vcs0: SUCCESS (0.001s)
[684.805485] Subtest resubmit-new: SUCCESS (0.009s)
[685.014514] [124/132] (375s left) kms_psr (fbc-psr-cursor-render)
[685.493739] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[685.808628] [125/132] (374s left) gem_exec_schedule (preempt-other)
[685.882120] Subtest preempt-other: SKIP (0.000s)
[686.116558] [126/132] (374s left) gem_mmap_wc (bad-object)
[686.171981] Starting subtest: bad-object
[686.172771] Subtest bad-object: SUCCESS (0.000s)
[686.313415] [127/132] (373s left) gem_exec_balancer (parallel-keep-submit-fence)
[686.374818] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[686.512476] [128/132] (373s left) gem_eio (in-flight-internal-10ms)
[686.575288] Starting subtest: in-flight-internal-10ms
[686.626963] Subtest in-flight-internal-10ms: SUCCESS (0.051s)
[687.664886] [129/132] (372s left) gem_exec_alignment (single)
[687.727451] Starting subtest: single
[687.729854] Subtest single: SUCCESS (0.003s)
[687.883693] [130/132] (372s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[687.939117] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[688.012845] [131/132] (372s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[688.498252] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[688.499695] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[689.118910] [132/132] (371s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[689.181876] Starting subtest: yf-tiled-to-vebox-yf-tiled
[689.183903] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[689.427717] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_plane_scaling
results: parsing output: 3/ for test: sysfs_preempt_timeout
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_bad_reloc
results: parsing output: 14/ for test: kms_hdr
results: parsing output: 15/ for test: gem_pread
results: parsing output: 16/ for test: kms_psr2_su
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: kms_cursor_legacy
results: parsing output: 19/ for test: gem_exec_async
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_pm_dc
results: parsing output: 22/ for test: kms_dither
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_async_flips
results: parsing output: 27/ for test: kms_lease
results: parsing output: 28/ for test: kms_setmode
results: parsing output: 29/ for test: kms_rotation_crc
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: gem_ctx_param
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_chamelium_audio
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: i915_drm_fdinfo
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_atomic
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: i915_pm_rpm
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: kms_concurrent
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: gem_mmap
results: parsing output: 53/ for test: gem_exec_flush
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: i915_pciid
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: gem_mmap_gtt
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_busy
results: parsing output: 71/ for test: kms_universal_plane
results: parsing output: 72/ for test: kms_selftest
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: gem_exec_balancer
results: parsing output: 78/ for test: kms_chamelium_frames
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: prime_self_import
results: parsing output: 83/ for test: gem_ppgtt
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_watchdog
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: gem_exec_whisper
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_chamelium_hpd
results: parsing output: 99/ for test: drm_read
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_mmap_wc
results: parsing output: 103/ for test: gem_ctx_engines
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: gem_mmap_offset
results: parsing output: 107/ for test: gem_huc_copy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_suspend
results: parsing output: 110/ for test: kms_atomic_interruptible
results: parsing output: 111/ for test: kms_plane_lowres
results: parsing output: 112/ for test: api_intel_allocator
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: api_intel_bb
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_spin_batch
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: gem_exec_schedule
results: parsing output: 125/ for test: gem_mmap_wc
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: gem_exec_alignment
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_render_copy
Done.