[68.379284] Initializing watchdogs
[68.379429]   /dev/watchdog0
[68.402625] [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)
[68.410552] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.414740] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.419197] [001/132] (960s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[68.492236] Starting subtest: invalid-single-wait-all-unsubmitted
[68.494059] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[68.614185] [002/132] (960s left) kms_cursor_crc (cursor-sliding-64x21)
[69.128079] Starting subtest: cursor-sliding-64x21
[69.178089] Subtest cursor-sliding-64x21: SKIP (0.060s)
[69.781562] [003/132] (959s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[70.275019] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[70.276813] Starting dynamic subtest: pipe-A
[70.281801] Dynamic subtest pipe-A: SKIP (0.002s)
[70.292564] Starting dynamic subtest: pipe-B
[70.298121] Dynamic subtest pipe-B: SKIP (0.001s)
[70.301422] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SKIP (0.004s)
[70.872761] [004/132] (958s left) sysfs_preempt_timeout (timeout)
[70.938181] Starting subtest: timeout
[70.939827] Starting dynamic subtest: vcs0
[70.943089] Dynamic subtest vcs0: SKIP (0.000s)
[70.958658] Starting dynamic subtest: bcs0
[70.962648] Dynamic subtest bcs0: SKIP (0.000s)
[70.976438] Starting dynamic subtest: rcs0
[70.980568] Dynamic subtest rcs0: SKIP (0.000s)
[70.984794] Subtest timeout: SKIP (0.002s)
[71.059086] [005/132] (958s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[71.117360] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[71.167375] [006/132] (957s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[71.227551] Starting subtest: etime-multi-wait-all-available-unsubmitted
[71.332821] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.105s)
[71.458662] [007/132] (957s left) perf (gen8-unprivileged-single-ctx-counters)
[71.617808] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[71.667672] [008/132] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[72.159513] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[72.162750] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[72.749880] [009/132] (956s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[73.253549] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[73.258518] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[73.851978] [010/132] (955s left) kms_flip (basic-flip-vs-dpms)
[74.339356] Starting subtest: basic-flip-vs-dpms
[74.341090] Starting dynamic subtest: A-VGA1
[75.136174] Dynamic subtest A-VGA1: SUCCESS (0.796s)
[75.145954] Starting dynamic subtest: B-VGA1
[75.822068] Dynamic subtest B-VGA1: SUCCESS (0.685s)
[75.831968] Starting dynamic subtest: A-HDMI-A1
[76.591191] Dynamic subtest A-HDMI-A1: SUCCESS (0.768s)
[76.600605] Starting dynamic subtest: B-HDMI-A1
[77.379544] Dynamic subtest B-HDMI-A1: SUCCESS (0.789s)
[77.381253] Subtest basic-flip-vs-dpms: SUCCESS (3.043s)
[78.101126] [011/132] (951s left) syncobj_timeline (invalid-transfer-non-existent-point)
[78.163573] Starting subtest: invalid-transfer-non-existent-point
[78.165148] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[78.287491] [012/132] (951s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[78.781424] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[80.410951] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.632s)
[81.037520] [013/132] (948s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[81.099492] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.000s)
[81.147208] [014/132] (948s left) gem_bad_reloc (negative-reloc)
[81.209338] Starting subtest: negative-reloc
[81.212946] Subtest negative-reloc: SKIP (0.000s)
[81.387980] [015/132] (948s left) kms_hdr (bpc-switch-dpms)
[81.876916] Starting subtest: bpc-switch-dpms
[87.673608] Subtest bpc-switch-dpms: SKIP (5.795s)
[88.462333] [016/132] (941s left) gem_pread (uncached)
[88.528383] Starting subtest: uncached
[89.864082] Subtest uncached: SUCCESS (1.333s)
[89.998099] [017/132] (939s left) kms_psr2_su (frontbuffer-xrgb8888)
[90.058457] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[90.113058] [018/132] (939s left) gem_exec_params (invalid-bsd2-flag-on-render)
[90.174665] Starting subtest: invalid-bsd2-flag-on-render
[90.176384] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[90.311379] [019/132] (939s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[90.803102] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[90.806468] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[91.410147] [020/132] (938s left) gem_exec_async (concurrent-writes)
[91.475505] Starting subtest: concurrent-writes
[91.477192] Starting dynamic subtest: rcs0
[91.478848] Dynamic subtest rcs0: SUCCESS (0.003s)
[91.491511] Starting dynamic subtest: bcs0
[91.493353] Dynamic subtest bcs0: SUCCESS (0.002s)
[91.504198] Starting dynamic subtest: vcs0
[91.506078] Dynamic subtest vcs0: SUCCESS (0.002s)
[91.507936] Subtest concurrent-writes: SUCCESS (0.009s)
[91.768980] [021/132] (938s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[92.259659] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[92.263129] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[92.863092] [022/132] (937s left) kms_pm_dc (dc5-psr)
[103.966237] Subtest dc5-psr: SKIP (0.000s)
[104.023911] [023/132] (925s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[104.514090] Starting subtest: fb-8bpc-vs-panel-8bpc
[104.515789] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.608373] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.092s)
[104.611629] Subtest fb-8bpc-vs-panel-8bpc: SKIP (0.094s)
[105.297685] [024/132] (924s left) kms_flip (blocking-absolute-wf_vblank)
[105.784832] Starting subtest: blocking-absolute-wf_vblank
[105.786653] Starting dynamic subtest: A-VGA1
[113.558807] Dynamic subtest A-VGA1: SUCCESS (7.773s)
[113.568849] Starting dynamic subtest: B-VGA1
[121.293851] Dynamic subtest B-VGA1: SUCCESS (7.733s)
[121.305565] Starting dynamic subtest: A-HDMI-A1
[129.199085] Dynamic subtest A-HDMI-A1: SUCCESS (7.903s)
[129.211094] Starting dynamic subtest: B-HDMI-A1
[137.137409] Dynamic subtest B-HDMI-A1: SUCCESS (7.936s)
[137.139301] Subtest blocking-absolute-wf_vblank: SUCCESS (31.354s)
[137.925610] [025/132] (892s left) gem_exec_fence (long-history)
[138.172810] Starting subtest: long-history
[138.244198] Subtest long-history: SUCCESS (0.072s)
[138.595564] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[138.599139] [026/132] (891s left) kms_big_fb (linear-64bpp-rotate-90)
[139.096477] Starting subtest: linear-64bpp-rotate-90
[139.115678] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[139.733466] [027/132] (890s left) kms_async_flips (async-flip-hang)
[140.225133] Starting subtest: async-flip-hang
[140.372806] Starting dynamic subtest: pipe-A-HDMI-A-1
[147.894828] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (7.523s)
[148.061149] Starting dynamic subtest: pipe-B-HDMI-A-1
[153.907635] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.855s)
[153.909219] Subtest async-flip-hang: SUCCESS (13.684s)
[154.734779] [028/132] (875s left) kms_lease (lease-unleased-crtc)
[155.222071] Starting subtest: lease-unleased-crtc
[155.223826] Starting dynamic subtest: pipe-A-HDMI-A-1
[155.337963] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.116s)
[155.350198] Starting dynamic subtest: pipe-B-HDMI-A-1
[155.374763] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.031s)
[155.376478] Subtest lease-unleased-crtc: SUCCESS (0.152s)
[156.060762] [029/132] (874s left) kms_setmode (invalid-clone-single-crtc)
[156.121664] Starting subtest: invalid-clone-single-crtc
[156.126608] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[156.251274] [030/132] (874s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[156.741143] Starting subtest: primary-yf-tiled-reflect-x-270
[156.744568] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[157.347868] [031/132] (873s left) gem_lmem_swapping (verify-ccs)
[157.413320] Subtest verify-ccs: SKIP (0.000s)
[157.473228] [032/132] (873s left) gem_mmap_gtt (basic-small-bo-tiledx)
[157.532979] Starting subtest: basic-small-bo-tiledX
[157.994805] Subtest basic-small-bo-tiledX: SUCCESS (0.461s)
[158.160995] [033/132] (872s left) kms_psr (fbc-pr-sprite-blt)
[158.733338] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[159.041048] [034/132] (871s left) gem_ctx_param (invalid-get-no-zeromap)
[159.101197] Starting subtest: invalid-get-no-zeromap
[159.103175] Subtest invalid-get-no-zeromap: SUCCESS (0.000s)
[159.235371] [035/132] (871s left) gem_exec_params (rsvd2-dirt)
[159.294957] Starting subtest: rsvd2-dirt
[159.298762] Subtest rsvd2-dirt: SKIP (0.000s)
[159.451470] [036/132] (871s left) kms_chamelium_audio (dp-audio-edid)
[160.019825] Subtest dp-audio-edid: SKIP (0.000s)
[160.411305] [037/132] (870s left) gem_userptr_blits (stress-mm-invalidate-close)
[160.491290] Starting subtest: stress-mm-invalidate-close
[162.639707] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[162.803962] [038/132] (868s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[162.865876] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[162.928394] [039/132] (867s left) i915_drm_fdinfo (virtual-busy-all)
[162.994085] Subtest virtual-busy-all: SKIP (0.000s)
[163.060598] [040/132] (867s left) kms_plane (plane-panning-bottom-right)
[163.547222] Starting subtest: plane-panning-bottom-right
[163.548932] Starting dynamic subtest: pipe-A
[164.141813] Dynamic subtest pipe-A: SUCCESS (0.593s)
[164.152797] Starting dynamic subtest: pipe-B
[164.749806] Dynamic subtest pipe-B: SUCCESS (0.606s)
[164.751512] Subtest plane-panning-bottom-right: SUCCESS (1.204s)
[165.460847] [041/132] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[165.964669] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[165.967892] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[166.561524] [042/132] (864s left) kms_atomic (atomic-plane-damage)
[167.049056] Starting subtest: atomic-plane-damage
[167.374923] Subtest atomic-plane-damage: SKIP (0.326s)
[168.165549] [043/132] (862s left) kms_flip (modeset-vs-vblank-race)
[168.654783] Starting subtest: modeset-vs-vblank-race
[168.656587] Starting dynamic subtest: A-VGA1
[171.731184] Dynamic subtest A-VGA1: SUCCESS (3.077s)
[171.744761] Starting dynamic subtest: B-VGA1
[174.756532] Dynamic subtest B-VGA1: SUCCESS (3.022s)
[174.770012] Starting dynamic subtest: A-HDMI-A1
[177.827416] Dynamic subtest A-HDMI-A1: SUCCESS (3.067s)
[177.841224] Starting dynamic subtest: B-HDMI-A1
[180.986978] Dynamic subtest B-HDMI-A1: SUCCESS (3.156s)
[180.988689] Subtest modeset-vs-vblank-race: SUCCESS (12.337s)
[181.784327] [044/132] (849s left) kms_psr (pr-cursor-plane-move)
[182.287635] Subtest pr-cursor-plane-move: SKIP (0.000s)
[182.601577] [045/132] (848s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[182.661960] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[182.730750] [046/132] (848s left) i915_pm_rpm (debugfs-read)
[194.596874] Subtest debugfs-read: SKIP (0.000s)
[194.959788] [047/132] (836s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[195.190124] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[195.214524] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[195.432154] [048/132] (836s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[195.493139] Starting subtest: single-wait-for-submit-unsubmitted
[195.596422] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[195.735379] [049/132] (835s left) kms_concurrent (multi-plane-atomic-lowres)
[196.222770] Starting subtest: multi-plane-atomic-lowres
[196.224622] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.724487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.499s)
[196.726210] Subtest multi-plane-atomic-lowres: SUCCESS (0.502s)
[197.420598] [050/132] (834s left) gem_mmap_gtt (basic-write-read-distinct)
[197.482130] Starting subtest: basic-write-read-distinct
[197.498096] Subtest basic-write-read-distinct: SUCCESS (0.017s)
[197.637785] [051/132] (834s left) kms_big_fb (4-tiled-addfb-size-overflow)
[198.143135] Starting subtest: 4-tiled-addfb-size-overflow
[198.147447] Subtest 4-tiled-addfb-size-overflow: SKIP (0.000s)
[198.760525] [052/132] (833s left) gem_render_copy (linear-to-vebox-yf-tiled)
[198.829211] Starting subtest: linear-to-vebox-yf-tiled
[198.832822] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[199.071987] [053/132] (832s left) gem_mmap (basic-small-bo)
[199.131423] Starting subtest: basic-small-bo
[199.529816] Subtest basic-small-bo: SUCCESS (0.397s)
[199.664232] [054/132] (832s left) gem_exec_flush (basic-wb-rw-before-default)
[199.816374] Starting subtest: basic-wb-rw-before-default
[205.261232] Subtest basic-wb-rw-before-default: SUCCESS (5.445s)
[205.503822] [055/132] (826s left) kms_flip (2x-flip-vs-suspend-interruptible)
[206.003806] Starting subtest: 2x-flip-vs-suspend-interruptible
[206.005550] Starting dynamic subtest: AB-VGA1-HDMI-A1
[394.048539] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[401.742799] Closing watchdogs
[401.748773] Initializing watchdogs
[401.748839]   /dev/watchdog0
[401.771454] [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)
[401.783293] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[401.784880] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[401.785596] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[401.789778] [056/132] (637s left) kms_cursor_crc (cursor-offscreen-512x512)
[402.295517] Starting subtest: cursor-offscreen-512x512
[402.298770] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[402.903238] [057/132] (636s left) kms_frontbuffer_tracking (fbc-tiling-4)
[403.399320] Starting subtest: fbc-tiling-4
[403.402557] Subtest fbc-tiling-4: SKIP (0.000s)
[404.020290] [058/132] (635s left) i915_pciid
[404.208922] [059/132] (635s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[404.705092] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[404.708331] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[405.324342] [060/132] (634s left) gem_exec_schedule (submit-early-slice)
[405.406739] Subtest submit-early-slice: SKIP (0.000s)
[405.643000] [061/132] (633s left) perf_pmu (busy-double-start)
[405.700914] Starting subtest: busy-double-start
[405.702705] Starting dynamic subtest: rcs0
[409.243076] Dynamic subtest rcs0: SUCCESS (3.531s)
[409.268758] Starting dynamic subtest: bcs0
[412.764082] Dynamic subtest bcs0: SUCCESS (3.512s)
[412.785052] Starting dynamic subtest: vcs0
[416.785062] Dynamic subtest vcs0: SUCCESS (4.013s)
[416.787279] Subtest busy-double-start: SUCCESS (11.063s)
[416.926102] [062/132] (622s left) gem_mmap_gtt (big-bo-tiledx)
[416.984835] Starting subtest: big-bo-tiledX
[417.325112] Subtest big-bo-tiledX: SUCCESS (0.339s)
[417.519129] [063/132] (622s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[418.095437] Starting subtest: cursor-vs-flip-varying-size
[452.722705] Subtest cursor-vs-flip-varying-size: SUCCESS (34.605s)
[453.427126] [064/132] (586s left) kms_properties (colorop-properties-legacy)
[453.911356] Starting subtest: colorop-properties-legacy
[453.912964] Starting dynamic subtest: pipe-A-HDMI-A-1
[454.038760] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.127s)
[454.055677] Starting dynamic subtest: pipe-B-HDMI-A-1
[454.256461] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.215s)
[454.258256] Subtest colorop-properties-legacy: SUCCESS (0.346s)
[454.957195] [065/132] (584s left) gem_exec_params (larger-than-life-batch)
[455.023409] Starting subtest: larger-than-life-batch
[455.026654] Subtest larger-than-life-batch: SKIP (0.000s)
[455.173648] [066/132] (584s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[455.658561] Starting subtest: 2x-flip-vs-cursor-atomic
[455.661908] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[456.280100] [067/132] (583s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[456.777508] Starting subtest: 2x-absolute-wf_vblank-interruptible
[456.781341] Starting dynamic subtest: AB-VGA1-HDMI-A1
[487.208875] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.414s)
[487.213799] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (30.418s)
[488.052341] [068/132] (551s left) gem_mmap_gtt (basic-read-write-distinct)
[488.115836] Starting subtest: basic-read-write-distinct
[488.130167] Subtest basic-read-write-distinct: SUCCESS (0.015s)
[488.299263] [069/132] (551s left) kms_pm_rpm (fences)
[500.077983] Subtest fences: SKIP (0.000s)
[500.383095] [070/132] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[500.882449] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[500.885719] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[501.492395] [071/132] (538s left) kms_busy (basic)
[501.986481] Starting subtest: basic
[501.988316] Starting dynamic subtest: flip
[502.420578] Dynamic subtest flip: SUCCESS (0.433s)
[502.434714] Starting dynamic subtest: modeset
[503.195986] Dynamic subtest modeset: SUCCESS (0.774s)
[503.197894] Subtest basic: SUCCESS (1.213s)
[503.916281] [072/132] (536s left) kms_universal_plane (universal-plane-sanity)
[504.402051] Starting subtest: universal-plane-sanity
[504.403709] Starting dynamic subtest: pipe-A-HDMI-A-1
[504.644463] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.242s)
[504.658630] Starting dynamic subtest: pipe-B-HDMI-A-1
[504.916008] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.269s)
[504.917693] Subtest universal-plane-sanity: SUCCESS (0.516s)
[505.636354] [073/132] (534s left) kms_selftest (drm_dp_mst_helper)
[505.710928] Starting subtest: drm_dp_mst_helper
[505.720437] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[505.827520] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.104s)
[505.850493] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[505.919999] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.090s)
[505.946143] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[506.017315] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.098s)
[506.019194] Subtest drm_dp_mst_helper: SUCCESS (0.309s)
[506.220573] [074/132] (534s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[506.282138] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[506.351253] [075/132] (534s left) gem_exec_reloc (basic-cpu-gtt-active)
[506.415772] Starting subtest: basic-cpu-gtt-active
[506.524520] Subtest basic-cpu-gtt-active: SUCCESS (0.110s)
[507.571176] [076/132] (532s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[507.630063] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[507.734325] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[507.871344] [077/132] (532s left) gem_userptr_blits (invalid-null-pointer)
[507.934080] Starting subtest: invalid-null-pointer
[507.935677] Subtest invalid-null-pointer: SUCCESS (0.001s)
[508.138070] [078/132] (532s left) gem_exec_balancer (full-late-pulse)
[508.199112] Subtest full-late-pulse: SKIP (0.000s)
[508.338619] [079/132] (532s left) kms_chamelium_frames (dp-crc-single)
[508.902056] Subtest dp-crc-single: SKIP (0.000s)
[509.309450] [080/132] (531s left) perf_pmu (semaphore-wait-idle)
[509.373762] Starting subtest: semaphore-wait-idle
[509.375464] Starting dynamic subtest: rcs0
[509.378712] Dynamic subtest rcs0: SKIP (0.001s)
[509.401664] Starting dynamic subtest: bcs0
[509.405733] Dynamic subtest bcs0: SKIP (0.000s)
[509.430017] Starting dynamic subtest: vcs0
[509.433877] Dynamic subtest vcs0: SKIP (0.000s)
[509.437695] Subtest semaphore-wait-idle: SKIP (0.006s)
[509.528578] [081/132] (531s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[510.019192] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[510.022354] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[510.622320] [082/132] (530s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[510.686614] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[510.790199] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[510.937483] [083/132] (529s left) prime_self_import (basic-with_one_bo)
[510.992305] Starting subtest: basic-with_one_bo
[510.995583] Subtest basic-with_one_bo: SUCCESS (0.003s)
[511.140428] [084/132] (529s left) gem_ppgtt (blt-vs-render-ctxn)
[511.229990] Starting subtest: blt-vs-render-ctxN
[543.800419] Subtest blt-vs-render-ctxN: SUCCESS (32.575s)
[543.966739] [085/132] (497s left) syncobj_wait (single-wait-all-submitted)
[544.094928] Starting subtest: single-wait-all-submitted
[544.197828] Subtest single-wait-all-submitted: SUCCESS (0.101s)
[544.329451] [086/132] (496s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[544.832931] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[544.836468] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[545.453470] [087/132] (495s left) kms_psr (psr-sprite-mmap-cpu)
[545.944516] Subtest psr-sprite-mmap-cpu: SKIP (0.000s)
[546.268578] [088/132] (494s left) perf (non-sampling-read-error)
[546.456146] Subtest non-sampling-read-error: SKIP (0.000s)
[546.518991] [089/132] (494s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[547.018421] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[547.021698] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[547.623322] [090/132] (493s left) gem_watchdog (default-physical)
[547.689285] Starting subtest: default-physical
[547.692824] Subtest default-physical: SKIP (0.003s)
[547.808812] [091/132] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[548.301783] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[548.305041] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[548.907362] [092/132] (492s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[549.400837] Starting subtest: x-tiled-addfb-size-offset-overflow
[549.435236] Subtest x-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[550.025645] [093/132] (491s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[550.523891] Starting subtest: yf-tiled-16bpp-rotate-0
[550.527275] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[551.138369] [094/132] (490s left) kms_cursor_crc (cursor-offscreen-128x128)
[551.639400] Starting subtest: cursor-offscreen-128x128
[551.641376] Starting dynamic subtest: pipe-A-HDMI-A-1
[554.069672] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.429s)
[554.113661] Starting dynamic subtest: pipe-B-HDMI-A-1
[556.498627] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.400s)
[556.500417] Subtest cursor-offscreen-128x128: SUCCESS (4.862s)
[557.217332] [095/132] (484s left) kms_psr (psr2-basic)
[557.712960] Subtest psr2-basic: SKIP (0.000s)
[558.032299] [096/132] (483s left) gem_exec_whisper (basic-fds-priority)
[558.104057] Starting subtest: basic-fds-priority
[558.108261] Subtest basic-fds-priority: SKIP (0.001s)
[558.353061] [097/132] (483s left) syncobj_timeline (wait-all-interrupted)
[558.415997] Starting subtest: wait-all-interrupted
[558.526510] Subtest wait-all-interrupted: SUCCESS (0.109s)
[558.668161] [098/132] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[559.164232] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[559.167499] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[559.762421] [099/132] (482s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[560.332686] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[560.733049] [100/132] (481s left) drm_read (short-buffer-wakeup)
[561.264828] Starting subtest: short-buffer-wakeup
[593.486707] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[594.150931] [101/132] (447s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[594.638447] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[596.603033] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.966s)
[597.242305] [102/132] (444s left) gem_ctx_persistence (legacy-engines-mixed-process)
[597.308183] Subtest legacy-engines-mixed-process: SKIP (0.000s)
[597.370274] [103/132] (444s left) gem_mmap_wc (write-read-distinct)
[597.427736] Starting subtest: write-read-distinct
[597.442296] Subtest write-read-distinct: SUCCESS (0.015s)
[597.609719] [104/132] (444s left) gem_ctx_engines (none)
[597.676715] Starting subtest: none
[597.678625] Subtest none: SUCCESS (0.001s)
[597.924397] [105/132] (444s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[598.414270] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[598.417571] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[599.031292] [106/132] (443s left) gem_exec_params (rel-constants-invalid-ring)
[599.093987] Starting subtest: rel-constants-invalid-ring
[599.095766] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[599.246549] [107/132] (443s left) gem_mmap_offset (bad-extensions)
[599.306823] Starting subtest: bad-extensions
[599.308713] Subtest bad-extensions: SUCCESS (0.000s)
[599.462779] [108/132] (442s left) gem_huc_copy (huc-copy)
[599.525309] Subtest huc-copy: SKIP (0.000s)
[599.591728] [109/132] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[600.090005] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[600.093293] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[600.707420] [110/132] (441s left) i915_suspend (fence-restore-tiled2untiled)
[600.771315] Starting subtest: fence-restore-tiled2untiled
[618.882675] Subtest fence-restore-tiled2untiled: SUCCESS (1.662s)
[624.038116] [111/132] (423s left) kms_atomic_interruptible (legacy-cursor)
[624.532519] Starting subtest: legacy-cursor
[624.534234] Starting dynamic subtest: pipe-A-HDMI-A-1
[630.874638] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.303s)
[630.876410] Subtest legacy-cursor: SUCCESS (6.306s)
[631.577552] [112/132] (416s left) kms_plane_lowres (tiling-4)
[632.072057] Starting subtest: tiling-4
[632.075545] Subtest tiling-4: SKIP (0.000s)
[632.679638] [113/132] (415s left) api_intel_allocator (standalone)
[632.741195] Starting subtest: standalone
[632.767512] Subtest standalone: SUCCESS (0.027s)
[632.950775] [114/132] (414s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[633.450447] Starting subtest: cursor-rapid-movement-128x128
[633.452573] Starting dynamic subtest: pipe-A-HDMI-A-1
[633.817021] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.364s)
[633.860627] Starting dynamic subtest: pipe-B-HDMI-A-1
[634.213382] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.366s)
[634.215073] Subtest cursor-rapid-movement-128x128: SUCCESS (0.764s)
[634.924277] [115/132] (412s left) kms_invalid_mode (overflow-vrefresh)
[635.419547] Starting subtest: overflow-vrefresh
[635.421294] Starting dynamic subtest: pipe-A-HDMI-A-1
[635.505929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.085s)
[635.523930] Starting dynamic subtest: pipe-B-HDMI-A-1
[635.525591] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[635.527402] Subtest overflow-vrefresh: SUCCESS (0.090s)
[635.986848] [116/132] (411s left) syncobj_timeline (reset-multiple-signaled)
[636.051653] Starting subtest: reset-multiple-signaled
[636.053546] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[636.189823] [117/132] (411s left) api_intel_bb (object-reloc-keep-cache)
[636.249334] Starting subtest: object-reloc-keep-cache
[636.250952] Subtest object-reloc-keep-cache: SUCCESS (0.002s)
[636.401403] [118/132] (411s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[636.896481] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[637.207335] [119/132] (410s left) gen9_exec_parse (basic-rejected)
[637.274358] Subtest basic-rejected: SKIP (0.000s)
[637.335802] [120/132] (410s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[637.825865] Starting subtest: flip-vs-cursor-atomic-transitions
[648.504766] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (10.665s)
[649.226558] [121/132] (398s left) kms_vblank (wait-idle)
[649.712868] Starting subtest: wait-idle
[649.715018] Starting dynamic subtest: pipe-A-HDMI-A-1
[651.924480] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.210s)
[651.941111] Starting dynamic subtest: pipe-B-HDMI-A-1
[654.176964] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.249s)
[654.178694] Subtest wait-idle: SUCCESS (4.464s)
[654.889945] [122/132] (393s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[655.379010] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[655.382355] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[655.998504] [123/132] (392s left) gem_spin_batch (resubmit-new)
[656.068757] Starting subtest: resubmit-new
[656.070536] Starting dynamic subtest: rcs0
[656.072251] Dynamic subtest rcs0: SUCCESS (0.002s)
[656.087255] Starting dynamic subtest: bcs0
[656.088975] Dynamic subtest bcs0: SUCCESS (0.001s)
[656.103256] Starting dynamic subtest: vcs0
[656.104954] Dynamic subtest vcs0: SUCCESS (0.001s)
[656.106642] Subtest resubmit-new: SUCCESS (0.009s)
[656.308088] [124/132] (392s left) kms_psr (fbc-psr-cursor-render)
[656.799954] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[657.128193] [125/132] (391s left) gem_exec_schedule (preempt-other)
[657.200268] Subtest preempt-other: SKIP (0.000s)
[657.445099] [126/132] (391s left) gem_mmap_wc (bad-object)
[657.502373] Starting subtest: bad-object
[657.504057] Subtest bad-object: SUCCESS (0.000s)
[657.657212] [127/132] (390s left) gem_exec_balancer (parallel-keep-submit-fence)
[657.722513] Subtest parallel-keep-submit-fence: SKIP (0.000s)
[657.855233] [128/132] (390s left) gem_eio (in-flight-internal-10ms)
[657.921816] Starting subtest: in-flight-internal-10ms
[657.974853] Subtest in-flight-internal-10ms: SUCCESS (0.054s)
[659.031219] [129/132] (389s left) gem_exec_alignment (single)
[659.093496] Starting subtest: single
[659.095214] Subtest single: SUCCESS (0.003s)
[659.283368] [130/132] (389s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[659.340732] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[659.402218] [131/132] (389s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[659.889413] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[659.892620] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[660.491096] [132/132] (388s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[660.557307] Starting subtest: yf-tiled-to-vebox-yf-tiled
[660.561073] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[660.799719] 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.