[69.907257] Initializing watchdogs
[69.907382]   /dev/watchdog0
[69.928359] [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.938348] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.942125] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.949734] [001/133] (960s left) gem_exec_whisper (basic-sync-all)
[70.036172] Starting subtest: basic-sync-all
[71.048050] Subtest basic-sync-all: SUCCESS (1.010s)
[71.288262] [002/133] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[71.785169] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[71.788460] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[72.399797] [003/133] (958s left) kms_flip (plain-flip-interruptible)
[72.896377] Starting subtest: plain-flip-interruptible
[72.898059] Starting dynamic subtest: A-VGA1
[73.663161] Dynamic subtest A-VGA1: SUCCESS (0.766s)
[73.673344] Starting dynamic subtest: B-VGA1
[74.353237] Dynamic subtest B-VGA1: SUCCESS (0.689s)
[74.364247] Starting dynamic subtest: A-HDMI-A1
[75.092162] Dynamic subtest A-HDMI-A1: SUCCESS (0.738s)
[75.102915] Starting dynamic subtest: B-HDMI-A1
[75.857645] Dynamic subtest B-HDMI-A1: SUCCESS (0.764s)
[75.859779] Subtest plain-flip-interruptible: SUCCESS (2.964s)
[76.641417] [004/133] (953s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[77.142310] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[77.431124] [005/133] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[77.925648] Starting subtest: fbcpsr-rgb565-draw-blt
[77.928983] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[78.525019] [006/133] (952s left) kms_rotation_crc (bad-tiling)
[79.007960] Starting subtest: bad-tiling
[79.011473] Subtest bad-tiling: SKIP (0.001s)
[79.603086] [007/133] (951s left) api_intel_allocator (two-level-inception)
[79.665195] Starting subtest: two-level-inception
[85.097911] Subtest two-level-inception: SUCCESS (5.433s)
[85.229135] [008/133] (945s left) gem_exec_reloc (basic-wc-gtt-active)
[85.292670] Starting subtest: basic-wc-gtt-active
[85.403148] Subtest basic-wc-gtt-active: SUCCESS (0.110s)
[86.437688] [009/133] (944s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[86.933962] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[86.937261] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[87.535147] [010/133] (943s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[87.600985] Starting subtest: cpuset-basic-small-copy-odd
[88.743714] Subtest cpuset-basic-small-copy-odd: SUCCESS (1.144s)
[88.907308] [011/133] (942s left) gem_mmap_wc (pf-nonblock)
[89.042782] Starting subtest: pf-nonblock
[89.044352] Subtest pf-nonblock: SUCCESS (0.001s)
[89.203237] [012/133] (941s left) gem_exec_create (legacy)
[89.274890] Starting subtest: legacy
[89.276767] Starting dynamic subtest: smem
[91.328631] Dynamic subtest smem: SUCCESS (2.054s)
[91.330936] Subtest legacy: SUCCESS (2.054s)
[91.569142] [013/133] (939s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[92.067333] Starting subtest: fb-8bpc-vs-panel-6bpc
[92.069131] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.145665] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.077s)
[92.148902] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.078s)
[92.855889] [014/133] (938s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[93.356409] Starting subtest: x-tiled-8bpp-rotate-0
[94.535445] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.178s)
[95.166427] [015/133] (936s left) kms_cursor_crc (cursor-onscreen-128x42)
[95.661483] Starting subtest: cursor-onscreen-128x42
[95.720351] Subtest cursor-onscreen-128x42: SKIP (0.055s)
[96.314591] [016/133] (934s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[96.389108] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[96.491661] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s)
[96.615562] [017/133] (934s left) syncobj_wait (wait-all-interrupted)
[96.676878] Starting subtest: wait-all-interrupted
[96.778933] Subtest wait-all-interrupted: SUCCESS (0.102s)
[96.891789] [018/133] (934s left) kms_busy (extended-modeset-hang-newfb)
[97.383170] Starting subtest: extended-modeset-hang-newfb
[97.384941] Starting dynamic subtest: pipe-A
[110.066718] Dynamic subtest pipe-A: SUCCESS (12.680s)
[110.078687] Starting dynamic subtest: pipe-B
[122.015032] Dynamic subtest pipe-B: SUCCESS (11.952s)
[122.016788] Subtest extended-modeset-hang-newfb: SUCCESS (24.636s)
[122.721383] [019/133] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[123.228445] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[123.231664] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[123.819553] [020/133] (907s left) syncobj_timeline (reset-multiple-signaled)
[123.879393] Starting subtest: reset-multiple-signaled
[123.881045] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[124.002286] [021/133] (907s left) gem_exec_schedule (wide)
[124.070380] Subtest wide: SKIP (0.000s)
[124.308978] [022/133] (907s left) gem_ctx_engines (none)
[124.373907] Starting subtest: none
[124.376037] Subtest none: SUCCESS (0.001s)
[124.622606] [023/133] (907s left) gen7_exec_parse (batch-without-end)
[124.685299] Subtest batch-without-end: SKIP (0.000s)
[124.750234] [024/133] (906s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[124.808490] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[124.861842] [025/133] (906s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[125.352141] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[125.358229] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[125.930115] [026/133] (905s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[125.986437] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[126.091796] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[126.222065] [027/133] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[126.717164] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[126.720284] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[127.310919] [028/133] (904s left) gem_exec_schedule (promotion)
[127.384154] Subtest promotion: SKIP (0.000s)
[127.617355] [029/133] (904s left) gem_exec_schedule (independent)
[127.682499] Starting subtest: independent
[127.684205] Starting dynamic subtest: rcs0
[127.743554] Dynamic subtest rcs0: SUCCESS (0.060s)
[127.757217] Starting dynamic subtest: bcs0
[127.791225] Dynamic subtest bcs0: SUCCESS (0.046s)
[127.793484] Subtest independent: SUCCESS (0.109s)
[128.028035] [030/133] (903s left) prime_self_import (basic-llseek-size)
[128.080072] Starting subtest: basic-llseek-size
[128.085389] Subtest basic-llseek-size: SUCCESS (0.005s)
[128.247396] [031/133] (903s left) gem_exec_reloc (basic-gtt-wc)
[128.307786] Starting subtest: basic-gtt-wc
[128.311340] Subtest basic-gtt-wc: SUCCESS (0.004s)
[129.365510] [032/133] (902s left) i915_hangman (engine-error-state-capture)
[129.434236] Subtest engine-error-state-capture: SKIP (0.000s)
[129.516948] [033/133] (902s left) kms_plane_cursor (overlay)
[130.010125] Starting subtest: overlay
[130.013709] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[132.703151] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.691s)
[132.762107] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[135.464179] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.711s)
[135.523547] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[138.224273] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.710s)
[138.372131] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[141.140201] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.781s)
[141.200754] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[143.884683] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.694s)
[143.946892] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[146.645618] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.711s)
[146.777616] Subtest overlay: SUCCESS (16.769s)
[147.500332] [034/133] (884s left) sysfs_timeslice_duration (timeout)
[147.565536] Starting subtest: timeout
[147.567116] Starting dynamic subtest: vcs0
[147.570389] Dynamic subtest vcs0: SKIP (0.000s)
[147.589845] Starting dynamic subtest: bcs0
[147.593981] Dynamic subtest bcs0: SKIP (0.000s)
[147.613443] Starting dynamic subtest: rcs0
[147.617254] Dynamic subtest rcs0: SKIP (0.000s)
[147.621065] Subtest timeout: SKIP (0.003s)
[147.674056] [035/133] (884s left) dumb_buffer (invalid-bpp)
[147.738100] Starting subtest: invalid-bpp
[147.739801] Subtest invalid-bpp: SUCCESS (0.000s)
[147.862888] [036/133] (884s left) gem_exec_nop (basic-parallel)
[147.930786] Starting subtest: basic-parallel
[150.730988] Subtest basic-parallel: SUCCESS (2.799s)
[151.009055] [037/133] (881s left) kms_addfb_basic (bad-pitch-256)
[151.066649] Starting subtest: bad-pitch-256
[151.068273] Subtest bad-pitch-256: SUCCESS (0.000s)
[152.083653] [038/133] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[152.583117] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[154.414847] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.836s)
[155.027435] [039/133] (877s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[155.523272] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[155.526571] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[156.132861] [040/133] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[156.631855] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[156.647130] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[157.208233] [041/133] (875s left) gem_exec_balancer (bonded-sync)
[157.271098] Subtest bonded-sync: SKIP (0.000s)
[157.393851] [042/133] (875s left) i915_drm_fdinfo (busy)
[157.453754] Subtest busy: SKIP (0.000s)
[157.520090] [043/133] (875s left) gem_exec_create (forked)
[157.588504] Starting subtest: forked
[157.590467] Starting dynamic subtest: smem
[177.699707] Dynamic subtest smem: SUCCESS (20.111s)
[177.702032] Subtest forked: SUCCESS (20.112s)
[177.918770] [044/133] (854s left) kms_pm_rpm (modeset-non-lpsp)
[189.710732] Subtest modeset-non-lpsp: SKIP (0.000s)
[190.007096] [045/133] (842s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[190.077252] Starting subtest: yf-tiled-ccs-to-x-tiled
[190.079229] Starting dynamic subtest: smem
[190.082781] Dynamic subtest smem: SKIP (0.000s)
[190.086665] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.001s)
[190.309619] [046/133] (842s left) gem_userptr_blits (nohangcheck)
[190.399056] Starting subtest: nohangcheck
[190.444162] Subtest nohangcheck: SUCCESS (0.048s)
[190.619095] [047/133] (842s left) gem_spin_batch (legacy)
[190.686350] Starting subtest: legacy
[190.688142] Starting dynamic subtest: default
[193.999163] Dynamic subtest default: SUCCESS (3.310s)
[194.011186] Starting dynamic subtest: render
[197.310143] Dynamic subtest render: SUCCESS (3.310s)
[197.322183] Starting dynamic subtest: bsd
[200.622162] Dynamic subtest bsd: SUCCESS (3.310s)
[200.634177] Starting dynamic subtest: bsd1
[203.932769] Dynamic subtest bsd1: SUCCESS (3.310s)
[203.944895] Starting dynamic subtest: blt
[207.244853] Dynamic subtest blt: SUCCESS (3.310s)
[207.246777] Subtest legacy: SUCCESS (16.556s)
[207.531441] [048/133] (825s left) kms_content_protection (dp-mst-lic-type-0)
[208.048846] Starting subtest: dp-mst-lic-type-0
[208.052175] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[208.654529] [049/133] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[209.147997] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[209.151349] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[209.756435] [050/133] (823s left) kms_plane (pixel-format-y-tiled-modifier)
[210.259621] Starting subtest: pixel-format-y-tiled-modifier
[210.268329] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[210.868559] [051/133] (822s left) prime_vgem (fence-flip-hang)
[210.993142] Subtest fence-flip-hang: SKIP (0.000s)
[211.135302] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[211.139808] [052/133] (822s left) syncobj_basic (bad-fd-to-handle)
[211.196272] Starting subtest: bad-fd-to-handle
[211.197928] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[211.319519] [053/133] (821s left) kms_chamelium_hpd (vga-hpd)
[211.884207] Subtest vga-hpd: SKIP (0.000s)
[212.320572] [054/133] (821s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[212.817819] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[212.822528] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[213.433422] [055/133] (820s left) kms_selftest (drm_dp_mst_helper)
[213.499060] Starting subtest: drm_dp_mst_helper
[213.506963] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[213.601802] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.096s)
[213.617586] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[213.721669] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.118s)
[213.734167] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[213.806611] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.085s)
[213.808193] Subtest drm_dp_mst_helper: SUCCESS (0.309s)
[213.977324] [056/133] (819s left) prime_self_import (reimport-vs-gem_close-race)
[214.032784] Starting subtest: reimport-vs-gem_close-race
[219.061700] Subtest reimport-vs-gem_close-race: SUCCESS (5.028s)
[219.202543] [057/133] (814s left) kms_flip (blocking-absolute-wf_vblank)
[219.698869] Starting subtest: blocking-absolute-wf_vblank
[219.700692] Starting dynamic subtest: A-VGA1
[227.463544] Dynamic subtest A-VGA1: SUCCESS (7.763s)
[227.480673] Starting dynamic subtest: B-VGA1
[235.188724] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[235.203180] Starting dynamic subtest: A-HDMI-A1
[243.078051] Dynamic subtest A-HDMI-A1: SUCCESS (7.887s)
[243.093114] Starting dynamic subtest: B-HDMI-A1
[250.996652] Dynamic subtest B-HDMI-A1: SUCCESS (7.916s)
[250.998517] Subtest blocking-absolute-wf_vblank: SUCCESS (31.301s)
[251.787356] [058/133] (781s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[251.845379] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[251.955589] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[252.061448] [059/133] (781s left) gem_reg_read (timestamp-monotonic)
[252.131755] Starting subtest: timestamp-monotonic
[256.575216] Subtest timestamp-monotonic: SUCCESS (4.443s)
[256.692373] [060/133] (777s left) gem_ctx_param (invalid-set-ringsize)
[256.751406] Starting subtest: invalid-set-ringsize
[256.752965] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[256.878077] [061/133] (776s left) kms_chamelium_color (ctm-blue-to-red)
[257.373437] Subtest ctm-blue-to-red: SKIP (0.000s)
[257.671508] [062/133] (776s left) gem_ctx_param (invalid-size-get)
[257.730693] Starting subtest: invalid-size-get
[257.732310] Subtest invalid-size-get: SUCCESS (0.000s)
[257.855571] [063/133] (776s left) perf_pmu (busy-idle-no-semaphores)
[257.922897] Starting subtest: busy-idle-no-semaphores
[257.924934] Starting dynamic subtest: rcs0
[258.546361] Dynamic subtest rcs0: SUCCESS (0.623s)
[258.561011] Starting dynamic subtest: bcs0
[259.163872] Dynamic subtest bcs0: SUCCESS (0.616s)
[259.179750] Starting dynamic subtest: vcs0
[260.287872] Dynamic subtest vcs0: SUCCESS (1.123s)
[260.289905] Subtest busy-idle-no-semaphores: SUCCESS (2.366s)
[260.456485] [064/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[260.951759] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[260.955088] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[261.534532] [065/133] (772s left) gem_exec_async (forked-writes)
[261.604919] Starting subtest: forked-writes
[261.606729] Starting dynamic subtest: rcs0
[261.620292] Dynamic subtest rcs0: SUCCESS (0.015s)
[261.633738] Starting dynamic subtest: bcs0
[261.637858] Dynamic subtest bcs0: SUCCESS (0.014s)
[261.651042] Starting dynamic subtest: vcs0
[261.657845] Dynamic subtest vcs0: SUCCESS (0.020s)
[261.659545] Subtest forked-writes: SUCCESS (0.054s)
[261.933237] [066/133] (772s left) kms_psr (fbc-pr-basic)
[262.427941] Subtest fbc-pr-basic: SKIP (0.000s)
[262.724909] [067/133] (771s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[263.210397] Starting subtest: basic-flip-before-cursor-varying-size
[264.189467] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.978s)
[264.905586] [068/133] (769s left) kms_addfb_basic (invalid-set-prop-any)
[264.968833] Starting subtest: invalid-set-prop-any
[264.990078] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[266.003674] [069/133] (768s left) kms_psr (fbc-psr2-cursor-plane-move)
[266.497743] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[266.795236] [070/133] (767s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[267.280052] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[267.281774] Starting dynamic subtest: pipe-A
[267.286645] Dynamic subtest pipe-A: SKIP (0.001s)
[267.299487] Starting dynamic subtest: pipe-B
[267.304091] Dynamic subtest pipe-B: SKIP (0.001s)
[267.307140] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.004s)
[267.898311] [071/133] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[268.396081] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[270.355056] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.962s)
[271.015253] [072/133] (763s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[271.082422] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[271.084074] Starting dynamic subtest: smem
[271.087781] Dynamic subtest smem: SKIP (0.000s)
[271.091470] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[271.287797] [073/133] (763s left) kms_hdr (bpc-switch)
[271.777481] Starting subtest: bpc-switch
[277.639648] Subtest bpc-switch: SKIP (5.859s)
[278.430348] [074/133] (756s left) gem_tiled_wb
[287.021840] [075/133] (747s left) gem_workarounds (basic-read-context)
[287.091975] Starting subtest: basic-read-context
[287.096673] Subtest basic-read-context: SUCCESS (0.005s)
[287.254741] [076/133] (747s left) prime_vgem (basic-blt)
[287.320172] Starting subtest: basic-blt
[287.341433] Subtest basic-blt: SUCCESS (0.022s)
[287.502578] [077/133] (747s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[287.992785] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[287.996029] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[288.603718] [078/133] (746s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[289.101081] Starting subtest: y-tiled-8bpp-rotate-180
[289.104731] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[289.722273] [079/133] (745s left) i915_pm_rpm (reg-read-ioctl)
[301.533271] Subtest reg-read-ioctl: SKIP (0.000s)
[301.829756] [080/133] (733s left) gem_exec_alignment (single)
[301.897615] Starting subtest: single
[301.899443] Subtest single: SUCCESS (0.002s)
[302.050884] [081/133] (732s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[302.111607] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[302.180644] [082/133] (732s left) gem_userptr_blits (unsync-overlap)
[302.245790] Subtest unsync-overlap: SKIP (0.000s)
[302.407693] [083/133] (732s left) kms_psr (psr-sprite-mmap-gtt)
[302.895477] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[303.201309] [084/133] (731s left) kms_atomic_interruptible (legacy-cursor)
[303.709856] Starting subtest: legacy-cursor
[303.711581] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.001668] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.302s)
[310.005794] Subtest legacy-cursor: SUCCESS (6.305s)
[310.706120] [085/133] (724s left) kms_psr (fbc-psr-primary-page-flip)
[311.200412] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[311.496371] [086/133] (723s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[311.554530] Starting subtest: invalid-smem-bo-on-discrete
[311.557904] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[312.583414] [087/133] (722s left) gem_busy (close-race)
[312.655488] Starting subtest: close-race
[334.569527] Subtest close-race: SUCCESS (21.914s)
[334.921492] [088/133] (700s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[335.496776] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[335.498400] Starting dynamic subtest: AB-VGA1-HDMI-A1
[365.955548] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.457s)
[365.959849] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (30.462s)
[366.745776] [089/133] (668s left) kms_color (degamma)
[367.249928] Starting subtest: degamma
[367.251759] Starting dynamic subtest: pipe-A-HDMI-A-1
[367.256243] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[367.269168] Starting dynamic subtest: pipe-B-HDMI-A-1
[367.272465] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[367.275720] Subtest degamma: SKIP (0.005s)
[367.862923] [090/133] (667s left) perf_pmu (all-busy-idle-check-all)
[367.924218] Starting subtest: all-busy-idle-check-all
[368.545273] Subtest all-busy-idle-check-all: SUCCESS (0.621s)
[368.677236] [091/133] (666s left) perf (gen12-mi-rpc)
[368.863461] Subtest gen12-mi-rpc: SKIP (0.000s)
[368.924887] [092/133] (666s left) kms_dsc (dsc-with-output-formats)
[369.417593] Subtest dsc-with-output-formats: SKIP (0.000s)
[369.724670] [093/133] (665s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[370.219060] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[370.225590] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[370.840829] [094/133] (664s left) gem_exec_fence (syncobj-timeline-wait)
[371.164191] Starting subtest: syncobj-timeline-wait
[371.202780] Subtest syncobj-timeline-wait: SUCCESS (0.040s)
[371.477718] [095/133] (664s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[371.537416] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[371.609444] [096/133] (664s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[371.668930] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[371.739493] [097/133] (664s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[372.232807] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[374.691434] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.459s)
[375.347576] [098/133] (660s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[375.413262] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[375.469294] [099/133] (660s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[375.958615] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[376.259880] [100/133] (659s left) i915_suspend (sysfs-reader)
[376.321180] Starting subtest: sysfs-reader
[394.783287] Subtest sysfs-reader: SUCCESS (2.514s)
[400.907102] [101/133] (641s left) kms_lease (lease-revoke)
[401.419426] Starting subtest: lease-revoke
[401.421231] Starting dynamic subtest: pipe-A-HDMI-A-1
[401.469639] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.046s)
[401.485693] Starting dynamic subtest: pipe-B-HDMI-A-1
[401.511895] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.041s)
[401.516292] Subtest lease-revoke: SUCCESS (0.093s)
[402.153627] [102/133] (640s left) kms_invalid_mode (bad-hsync-start)
[402.654585] Starting subtest: bad-hsync-start
[402.656377] Starting dynamic subtest: pipe-A-HDMI-A-1
[402.741105] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.083s)
[402.760377] Starting dynamic subtest: pipe-B-HDMI-A-1
[402.762226] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[402.763972] Subtest bad-hsync-start: SUCCESS (0.088s)
[403.224509] [103/133] (639s left) kms_psr (psr2-sprite-plane-onoff)
[403.731014] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[404.057308] [104/133] (638s left) vgem_slow (nohang)
[404.134166] Starting subtest: nohang
[414.385556] Subtest nohang: SUCCESS (10.145s)
[414.515603] [105/133] (627s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[414.578503] Starting subtest: single-wait-all-for-submit-available-submitted
[414.580272] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[414.702388] [106/133] (627s left) gem_exec_reloc (basic-gtt)
[414.769375] Starting subtest: basic-gtt
[414.773174] Subtest basic-gtt: SUCCESS (0.004s)
[415.805245] [107/133] (626s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[416.314400] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[416.318971] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[416.938796] [108/133] (625s left) syncobj_wait (invalid-signal-one-illegal-handle)
[417.000620] Starting subtest: invalid-signal-one-illegal-handle
[417.002271] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[417.140957] [109/133] (625s left) kms_atomic (atomic-invalid-params)
[417.630594] Starting subtest: atomic-invalid-params
[417.632886] Starting dynamic subtest: pipe-A-HDMI-A-1
[417.853603] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.223s)
[417.855364] Subtest atomic-invalid-params: SUCCESS (0.225s)
[418.573085] [110/133] (624s left) kms_cursor_crc (cursor-sliding-128x42)
[419.073055] Starting subtest: cursor-sliding-128x42
[419.133680] Subtest cursor-sliding-128x42: SKIP (0.057s)
[419.748460] [111/133] (623s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[420.240986] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[420.244313] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[420.853329] [112/133] (621s left) kms_vblank (crtc-id)
[421.341745] Starting subtest: crtc-id
[421.343696] Starting dynamic subtest: pipe-A-HDMI-A-1
[421.607800] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.264s)
[421.626317] Starting dynamic subtest: pipe-B-HDMI-A-1
[421.895428] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.284s)
[421.897186] Subtest crtc-id: SUCCESS (0.554s)
[422.610815] [113/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[423.102264] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[423.105586] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.717162] [114/133] (619s left) kms_plane_cursor (primary)
[424.207419] Starting subtest: primary
[424.210693] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[426.653795] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.441s)
[426.703064] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[429.123873] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.432s)
[429.171883] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[431.608463] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.448s)
[431.749393] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[434.252342] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.519s)
[434.305758] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[436.719095] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.432s)
[436.768102] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[439.185876] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.432s)
[439.306675] Subtest primary: SUCCESS (15.092s)
[440.019602] [115/133] (603s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[440.082545] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[440.155200] [116/133] (602s left) kms_big_fb (linear-16bpp-rotate-180)
[440.651259] Starting subtest: linear-16bpp-rotate-180
[441.998569] Subtest linear-16bpp-rotate-180: SUCCESS (1.346s)
[442.641260] [117/133] (600s left) kms_vrr (flip-basic)
[443.140212] Starting subtest: flip-basic
[443.145006] Subtest flip-basic: SKIP (0.000s)
[443.757268] [118/133] (599s left) kms_chamelium_edid (vga-edid-read)
[444.323137] Subtest vga-edid-read: SKIP (0.000s)
[444.716241] [119/133] (598s left) kms_pm_dc (dc5-dpms-negative)
[455.828915] Subtest dc5-dpms-negative: SKIP (0.000s)
[455.908038] [120/133] (587s left) kms_cursor_crc (cursor-sliding-256x85)
[456.400099] Starting subtest: cursor-sliding-256x85
[456.458615] Subtest cursor-sliding-256x85: SKIP (0.055s)
[457.079610] [121/133] (586s left) gem_blits (basic)
[457.166144] Starting subtest: basic
[459.229938] Subtest basic: SUCCESS (2.062s)
[459.395562] [122/133] (584s left) gem_mmap_offset (blt-coherency)
[459.454613] Starting subtest: blt-coherency
[459.459006] Subtest blt-coherency: SUCCESS (0.005s)
[459.642385] [123/133] (583s left) syncobj_timeline (invalid-signal-bad-pad)
[459.707566] Starting subtest: invalid-signal-bad-pad
[459.709407] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[459.840397] [124/133] (583s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[459.900347] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.000s)
[459.974484] [125/133] (583s left) gem_exec_fence (syncobj-channel)
[460.181595] Starting subtest: syncobj-channel
[461.210820] Subtest syncobj-channel: SUCCESS (1.027s)
[461.597597] [126/133] (582s left) gem_userptr_blits (forbidden-operations)
[461.663377] Starting subtest: forbidden-operations
[461.665018] Subtest forbidden-operations: SUCCESS (0.001s)
[461.846424] [127/133] (581s left) gem_flink_basic (double-flink)
[461.905978] Starting subtest: double-flink
[461.907950] Subtest double-flink: SUCCESS (0.000s)
[462.058833] [128/133] (581s left) gem_ctx_persistence (heartbeat-hang)
[462.123963] Subtest heartbeat-hang: SKIP (0.000s)
[462.189975] [129/133] (581s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[462.686851] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[462.690201] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[463.302137] [130/133] (580s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[463.801106] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[463.807809] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.001s)
[464.431350] [131/133] (579s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[464.926272] Starting subtest: basic-flip-before-cursor-legacy
[465.908454] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.982s)
[466.633505] [132/133] (577s left) api_intel_bb (reset-flags)
[466.701446] Starting subtest: reset-flags
[466.706526] Subtest reset-flags: SUCCESS (0.007s)
[466.872578] [133/133] (577s left) kms_psr (pr-sprite-render)
[467.360042] Subtest pr-sprite-render: SKIP (0.000s)
[467.667868] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_whisper
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_rotation_crc
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_gtt
results: parsing output: 10/ for test: gem_mmap_wc
results: parsing output: 11/ for test: gem_exec_create
results: parsing output: 12/ for test: kms_dither
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_ctx_engines
results: parsing output: 22/ for test: gen7_exec_parse
results: parsing output: 23/ for test: kms_flip_scaled_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: prime_self_import
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: i915_hangman
results: parsing output: 32/ for test: kms_plane_cursor
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: gem_exec_nop
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: i915_drm_fdinfo
results: parsing output: 42/ for test: gem_exec_create
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_spin_batch
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: prime_vgem
results: parsing output: 51/ for test: syncobj_basic
results: parsing output: 52/ for test: kms_chamelium_hpd
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_selftest
results: parsing output: 55/ for test: prime_self_import
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: gem_reg_read
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_ctx_param
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_async
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_plane_scaling
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_render_copy
results: parsing output: 72/ for test: kms_hdr
results: parsing output: 73/ for test: gem_tiled_wb
results: parsing output: 74/ for test: gem_workarounds
results: parsing output: 75/ for test: prime_vgem
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: i915_pm_rpm
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_userptr_blits
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_atomic_interruptible
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_color
results: parsing output: 89/ for test: perf_pmu
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: kms_dsc
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_flip_scaled_crc
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: i915_suspend
results: parsing output: 100/ for test: kms_lease
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: vgem_slow
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: kms_atomic
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_plane_cursor
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_vrr
results: parsing output: 117/ for test: kms_chamelium_edid
results: parsing output: 118/ for test: kms_pm_dc
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: gem_userptr_blits
results: parsing output: 126/ for test: gem_flink_basic
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_cursor_legacy
results: parsing output: 131/ for test: api_intel_bb
results: parsing output: 132/ for test: kms_psr
Done.