[70.360347] Initializing watchdogs
[70.360501]   /dev/watchdog0
[70.380349] [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)
[70.388310] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[70.391751] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.395099] [001/131] (960s left) gen9_exec_parse (allowed-single)
[70.488253] Subtest allowed-single: SKIP (0.000s)
[70.538961] [002/131] (960s left) gem_ctx_engines (invalid-engines)
[70.599814] Starting subtest: invalid-engines
[70.606871] Subtest invalid-engines: SUCCESS (0.007s)
[70.823998] [003/131] (960s left) syncobj_timeline (invalid-signal-illegal-point)
[70.879403] Starting subtest: invalid-signal-illegal-point
[70.880119] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[70.957916] [004/131] (960s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[71.327939] Starting subtest: plane-upscale-20x20-with-modifiers
[71.328781] Starting dynamic subtest: pipe-A
[71.330867] Dynamic subtest pipe-A: SKIP (0.002s)
[71.339224] Starting dynamic subtest: pipe-B
[71.341827] Dynamic subtest pipe-B: SKIP (0.001s)
[71.343236] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.004s)
[71.776964] [005/131] (959s left) gen9_exec_parse (bb-start-out)
[71.837186] Subtest bb-start-out: SKIP (0.000s)
[71.882810] [006/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[72.253549] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[72.254959] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[72.687164] [007/131] (958s left) kms_cursor_crc (cursor-sliding-32x10)
[73.066795] Starting subtest: cursor-sliding-32x10
[73.124865] Subtest cursor-sliding-32x10: SKIP (0.057s)
[73.558289] [008/131] (957s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[73.930324] Starting subtest: 2x-flip-vs-rmfb-interruptible
[73.931749] Starting dynamic subtest: AB-VGA1-HDMI-A1
[104.339427] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.405s)
[104.340456] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.408s)
[104.984182] [009/131] (926s left) gem_exercise_blt (fast-copy-emit)
[105.058405] Subtest fast-copy-emit: SKIP (0.000s)
[105.111856] [010/131] (926s left) core_getversion (all-cards)
[105.161845] Starting subtest: all-cards
[105.175772] Subtest all-cards: SUCCESS (0.014s)
[105.240069] [011/131] (926s left) i915_query (query-topology-kernel-writes)
[105.292941] Starting subtest: query-topology-kernel-writes
[105.294496] Subtest query-topology-kernel-writes: SKIP (0.000s)
[105.387300] [012/131] (925s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[105.753918] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[105.754668] Starting dynamic subtest: pipe-A
[105.756631] Dynamic subtest pipe-A: SKIP (0.001s)
[105.766963] Starting dynamic subtest: pipe-B
[105.769068] Dynamic subtest pipe-B: SKIP (0.001s)
[105.770359] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s)
[106.179853] [013/131] (925s left) prime_busy (hang)
[106.240994] Starting subtest: hang
[106.241828] Starting dynamic subtest: rcs0
[111.863565] Dynamic subtest rcs0: SUCCESS (5.622s)
[111.874211] Starting dynamic subtest: bcs0
[117.874610] Dynamic subtest bcs0: SUCCESS (6.011s)
[117.885433] Starting dynamic subtest: vcs0
[123.885123] Dynamic subtest vcs0: SUCCESS (6.010s)
[123.885921] Subtest hang: SUCCESS (17.645s)
[123.993793] [014/131] (907s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[124.060855] Starting subtest: y-tiled-ccs-to-y-tiled
[124.062149] Starting dynamic subtest: smem
[124.064129] Dynamic subtest smem: SKIP (0.000s)
[124.065535] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[124.263938] [015/131] (907s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[124.637074] Starting subtest: x-tiled-8bpp-rotate-180
[125.938195] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.301s)
[126.432653] [016/131] (905s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[126.803361] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[126.804603] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[127.268322] [017/131] (904s left) kms_psr (psr-sprite-plane-onoff)
[127.635232] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[127.853467] [018/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[128.222977] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[128.224310] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[128.659280] [019/131] (903s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[129.034516] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[129.035992] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[129.473828] [020/131] (902s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[129.841607] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[129.843072] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[130.306960] [021/131] (901s left) kms_cursor_crc (cursor-suspend)
[130.679398] Starting subtest: cursor-suspend
[130.679960] Starting dynamic subtest: pipe-A-HDMI-A-1
[165.075785] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.953s)
[165.086785] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.076254] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.017s)
[200.077064] Subtest cursor-suspend: SUCCESS (3.973s)
[207.650352] [022/131] (831s left) syncobj_timeline (multi-wait-for-submit-signaled)
[207.738399] Starting subtest: multi-wait-for-submit-signaled
[207.740226] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[207.833511] [023/131] (831s left) perf_pmu (idle-no-semaphores)
[207.890673] Starting subtest: idle-no-semaphores
[207.891495] Starting dynamic subtest: rcs0
[208.412970] Dynamic subtest rcs0: SUCCESS (0.520s)
[208.435513] Starting dynamic subtest: bcs0
[208.950436] Dynamic subtest bcs0: SUCCESS (0.523s)
[208.975370] Starting dynamic subtest: vcs0
[209.485700] Dynamic subtest vcs0: SUCCESS (0.516s)
[209.486975] Subtest idle-no-semaphores: SUCCESS (1.563s)
[209.576534] [024/131] (829s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[209.961046] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[209.962257] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[210.436116] [025/131] (828s left) gem_eio (context-create)
[210.503722] Starting subtest: context-create
[210.530308] Subtest context-create: SUCCESS (0.026s)
[211.328145] [026/131] (827s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[211.713514] Starting subtest: basic-modeset-with-all-modifiers-formats
[211.853602] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[212.004261] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.147s)
[212.019928] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[212.020994] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.011s)
[212.032709] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[212.035194] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.016s)
[212.051705] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XBGR16161616F
[212.052799] Dynamic subtest pipe-A-HDMI-A-1-x-XBGR16161616F: SUCCESS (0.016s)
[212.189362] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (0.466s)
[212.758698] [027/131] (826s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[213.145307] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[215.116773] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.936s)
[215.607527] [028/131] (823s left) kms_psr2_su (frontbuffer-xrgb8888)
[215.665106] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[215.721166] [029/131] (823s left) gem_exec_schedule (out-order)
[215.787814] Subtest out-order: SKIP (0.000s)
[215.993272] [030/131] (823s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[216.372967] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[218.973105] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.570s)
[219.458660] [031/131] (819s left) i915_query (query-topology-coherent-slice-mask)
[219.513765] Starting subtest: query-topology-coherent-slice-mask
[219.515437] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[219.609152] [032/131] (819s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[219.977985] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[220.210460] [033/131] (819s left) gem_basic (multigpu-create-close)
[220.268544] Starting subtest: multigpu-create-close
[220.270081] Subtest multigpu-create-close: SKIP (0.000s)
[220.362148] [034/131] (819s left) gem_exec_balancer (parallel-contexts)
[220.417883] Subtest parallel-contexts: SKIP (0.000s)
[220.511016] [035/131] (819s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[220.883172] Starting subtest: fbcpsr-tiling-linear
[220.884376] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[221.354578] [036/131] (818s left) kms_lease (lease-invalid-plane)
[221.722436] Starting subtest: lease-invalid-plane
[221.723253] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.724091] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[221.736640] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.737467] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[221.738447] Subtest lease-invalid-plane: SUCCESS (0.004s)
[222.184985] [037/131] (817s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[222.560148] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[222.560947] Starting dynamic subtest: AB-VGA1-HDMI-A1
[287.055237] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (64.434s)
[287.059343] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (64.438s)
[287.701811] [038/131] (751s left) kms_pm_dc (dc5-dpms-negative)
[298.806359] Subtest dc5-dpms-negative: SKIP (0.000s)
[298.859493] [039/131] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[299.227480] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[299.230098] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[299.688633] [040/131] (740s left) gem_mmap_gtt (big-bo)
[299.752567] Starting subtest: big-bo
[300.288497] Subtest big-bo: SUCCESS (0.535s)
[300.455733] [041/131] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[300.929794] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[300.930996] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[301.367933] [042/131] (738s left) tools_test (tools_test)
[301.432696] Starting subtest: tools_test
[301.540845] Subtest tools_test: SUCCESS (0.116s)
[301.614480] [043/131] (738s left) kms_atomic_transition (modeset-transition)
[301.978148] Starting subtest: modeset-transition
[301.978856] Starting dynamic subtest: 1x-outputs
[302.941117] Dynamic subtest 1x-outputs: SUCCESS (0.962s)
[302.975763] Subtest modeset-transition: SUCCESS (0.998s)
[303.555873] [044/131] (736s left) gem_mmap_offset (partial-mmap)
[303.614923] Starting subtest: partial-mmap
[303.615580] Starting dynamic subtest: smem0
[303.619333] Dynamic subtest smem0: SUCCESS (0.005s)
[303.620148] Subtest partial-mmap: SUCCESS (0.006s)
[303.754051] [045/131] (736s left) kms_color (legacy-gamma-reset)
[304.114435] Starting subtest: legacy-gamma-reset
[304.115186] Starting dynamic subtest: pipe-A-HDMI-A-1
[304.251001] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.137s)
[304.266471] Starting dynamic subtest: pipe-B-HDMI-A-1
[304.267268] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s)
[304.268039] Subtest legacy-gamma-reset: SUCCESS (0.144s)
[304.812634] [046/131] (735s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[304.884587] Starting subtest: mixed-tiled-to-y-tiled-ccs
[304.885447] Starting dynamic subtest: smem
[304.886823] Dynamic subtest smem: SKIP (0.000s)
[304.888054] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.001s)
[305.078295] [047/131] (735s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[305.445134] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[305.685933] [048/131] (734s left) kms_vrr (flipline)
[306.045942] Starting subtest: flipline
[306.048227] Subtest flipline: SKIP (0.000s)
[306.487864] [049/131] (733s left) gem_pxp (regular-baseline-src-copy-readible)
[309.060976] Starting subtest: regular-baseline-src-copy-readible
[309.062631] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[309.150977] [050/131] (731s left) kms_psr (psr-primary-blt)
[309.515145] Subtest psr-primary-blt: SKIP (0.000s)
[309.760841] [051/131] (730s left) kms_chamelium_frames (dp-crc-fast)
[310.201502] Subtest dp-crc-fast: SKIP (0.000s)
[310.536774] [052/131] (729s left) gem_ctx_persistence (legacy-engines-mixed)
[310.600685] Subtest legacy-engines-mixed: SKIP (0.000s)
[310.654068] [053/131] (729s left) kms_pm_rpm (pm-caching)
[322.256557] Subtest pm-caching: SKIP (0.000s)
[322.508806] [054/131] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[322.872178] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[322.873267] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[323.315771] [055/131] (717s left) syncobj_basic (illegal-fd-to-handle)
[323.378680] Starting subtest: illegal-fd-to-handle
[323.379295] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[323.460739] [056/131] (717s left) api_intel_allocator (fork-simple-once)
[323.513105] Starting subtest: fork-simple-once
[323.540469] Subtest fork-simple-once: SUCCESS (0.026s)
[323.662950] [057/131] (716s left) gem_userptr_blits (unsync-unmap-after-close)
[323.720823] Subtest unsync-unmap-after-close: SKIP (0.000s)
[323.861570] [058/131] (716s left) syncobj_wait (multi-wait-all-signaled)
[323.929015] Starting subtest: multi-wait-all-signaled
[323.929882] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[324.031811] [059/131] (716s left) kms_dsc (dsc-with-output-formats-with-bpc)
[324.392732] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[324.618895] [060/131] (716s left) gem_create (create-ext-cpu-access-big)
[324.787050] Starting subtest: create-ext-cpu-access-big
[324.788669] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[324.877800] [061/131] (715s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[324.933445] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[324.987394] [062/131] (715s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[325.356207] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[325.357776] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[325.791811] [063/131] (715s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[326.152649] Starting subtest: psr-shrfb-scaledprimary
[326.153973] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[326.593164] [064/131] (714s left) i915_pm_freq_api (freq-basic-api)
[326.654237] Subtest freq-basic-api: SKIP (0.000s)
[326.720277] [065/131] (714s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[327.083454] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[327.084695] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[327.522773] [066/131] (713s left) perf (blocking)
[327.676270] Subtest blocking: SKIP (0.000s)
[327.730057] [067/131] (713s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[327.781128] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[327.846980] [068/131] (713s left) sysfs_defaults (readonly)
[327.904930] Starting subtest: readonly
[327.907155] Starting dynamic subtest: vcs0
[327.907861] Dynamic subtest vcs0: SUCCESS (0.001s)
[327.925069] Starting dynamic subtest: bcs0
[327.926142] Dynamic subtest bcs0: SUCCESS (0.001s)
[327.945750] Starting dynamic subtest: rcs0
[327.946709] Dynamic subtest rcs0: SUCCESS (0.001s)
[327.947594] Subtest readonly: SUCCESS (0.009s)
[328.004092] [069/131] (713s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[328.380244] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[328.382026] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[328.822583] [070/131] (712s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[328.879610] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[328.984288] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[329.090055] [071/131] (712s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[329.460376] Starting subtest: x-tiled-32bpp-rotate-180
[330.883494] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.422s)
[331.353788] [072/131] (710s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[331.722729] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[331.724252] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[332.169463] [073/131] (709s left) kms_3d
[336.003431] [074/131] (705s left) gem_reg_read (bad-register)
[336.069151] Starting subtest: bad-register
[336.069853] Subtest bad-register: SUCCESS (0.000s)
[336.178613] [075/131] (705s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[336.553826] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[336.555123] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[337.003982] [076/131] (704s left) gem_readwrite (new-obj)
[337.062902] Starting subtest: new-obj
[337.064129] Subtest new-obj: SUCCESS (0.000s)
[337.164998] [077/131] (704s left) kms_psr (pr-suspend)
[337.527305] Subtest pr-suspend: SKIP (0.000s)
[337.762897] [078/131] (703s left) gem_caching (writes)
[337.821305] Starting subtest: writes
[340.819788] Subtest writes: SUCCESS (2.998s)
[340.945053] [079/131] (700s left) kms_force_connector_basic (force-load-detect)
[341.014719] Starting subtest: force-load-detect
[341.224370] Subtest force-load-detect: SUCCESS (0.210s)
[341.651970] [080/131] (700s left) syncobj_timeline (32bits-limit)
[341.711549] Starting subtest: 32bits-limit
[341.712185] Subtest 32bits-limit: SUCCESS (0.001s)
[341.809838] [081/131] (700s left) gem_userptr_blits (coherency-unsync)
[341.867939] Subtest coherency-unsync: SKIP (0.000s)
[341.999161] [082/131] (699s left) gem_mmap_offset (bad-flags)
[342.056783] Starting subtest: bad-flags
[342.057714] Subtest bad-flags: SUCCESS (0.000s)
[342.169282] [083/131] (699s left) kms_fbcon_fbt (fbc)
[342.228327] Starting subtest: fbc
[345.655145] Subtest fbc: SUCCESS (3.425s)
[345.706895] [084/131] (696s left) kms_cursor_crc (cursor-random-256x256)
[346.072716] Starting subtest: cursor-random-256x256
[346.075196] Starting dynamic subtest: pipe-A-HDMI-A-1
[349.737457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.660s)
[349.789418] Starting dynamic subtest: pipe-B-HDMI-A-1
[353.461342] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.689s)
[353.462065] Subtest cursor-random-256x256: SUCCESS (7.388s)
[354.017160] [085/131] (688s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[354.077240] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[354.141910] [086/131] (687s left) gem_exec_params (invalid-bsd-ring)
[354.201469] Starting subtest: invalid-bsd-ring
[354.202261] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[354.324126] [087/131] (687s left) gem_exec_endless (dispatch)
[354.384679] Subtest dispatch: SKIP (0.000s)
[354.487973] [088/131] (687s left) kms_psr (fbc-psr-no-drrs)
[354.852106] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[355.093761] [089/131] (687s left) gem_userptr_blits (sync-overlap)
[355.162464] Starting subtest: sync-overlap
[355.163341] Subtest sync-overlap: SUCCESS (0.000s)
[355.297186] [090/131] (687s left) kms_plane_lowres (tiling-y)
[355.657664] Starting subtest: tiling-y
[355.658877] Subtest tiling-y: SKIP (0.000s)
[356.094511] [091/131] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[356.459953] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[356.461275] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[356.894104] [092/131] (685s left) kms_busy (extended-pageflip-hang-oldfb)
[357.264007] Starting subtest: extended-pageflip-hang-oldfb
[357.264769] Starting dynamic subtest: pipe-A
[357.442986] Dynamic subtest pipe-A: SUCCESS (0.178s)
[357.458336] Starting dynamic subtest: pipe-B
[357.696357] Dynamic subtest pipe-B: SUCCESS (0.251s)
[357.698498] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.436s)
[358.255701] [093/131] (684s left) gem_lmem_swapping (random-engines)
[358.318720] Subtest random-engines: SKIP (0.000s)
[358.380935] [094/131] (684s left) perf (gen8-unprivileged-single-ctx-counters)
[358.487094] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[358.547407] [095/131] (684s left) kms_chamelium_hpd (dp-hpd-storm)
[358.987511] Subtest dp-hpd-storm: SKIP (0.000s)
[359.327277] [096/131] (683s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[359.388359] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[359.389026] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[359.480044] [097/131] (683s left) gem_exec_schedule (u-semaphore-codependency)
[359.547910] Subtest u-semaphore-codependency: SKIP (0.000s)
[359.749031] [098/131] (683s left) kms_draw_crc (draw-method-mmap-cpu)
[360.115843] Starting subtest: draw-method-mmap-cpu
[360.117976] Starting dynamic subtest: xrgb8888-untiled
[360.413624] Dynamic subtest xrgb8888-untiled: SUCCESS (0.296s)
[360.429875] Starting dynamic subtest: rgb565-untiled
[360.696256] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[360.712529] Starting dynamic subtest: xrgb2101010-untiled
[361.012348] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s)
[361.030768] Starting dynamic subtest: xbgr16161616f-untiled
[361.361668] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.346s)
[361.380855] Starting dynamic subtest: xrgb8888-xtiled
[361.544801] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.179s)
[361.562989] Starting dynamic subtest: rgb565-xtiled
[361.710991] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[361.729853] Starting dynamic subtest: xrgb2101010-xtiled
[361.894065] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.179s)
[361.910636] Starting dynamic subtest: xbgr16161616f-xtiled
[362.093706] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.196s)
[362.096641] Subtest draw-method-mmap-cpu: SUCCESS (1.978s)
[362.557348] [099/131] (680s left) kms_prop_blob (invalid-get-prop-any)
[362.615535] Starting subtest: invalid-get-prop-any
[362.616129] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[362.717953] [100/131] (680s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[363.077277] Starting subtest: addfb25-y-tiled-legacy
[363.078096] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[363.522218] [101/131] (679s left) gem_spin_batch (spin-all)
[363.591602] Starting subtest: spin-all
[363.593821] Subtest spin-all: SUCCESS (0.003s)
[363.787125] [102/131] (679s left) kms_invalid_mode (bad-vtotal)
[364.151118] Starting subtest: bad-vtotal
[364.151938] Starting dynamic subtest: pipe-A-HDMI-A-1
[364.221725] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.071s)
[364.236584] Starting dynamic subtest: pipe-B-HDMI-A-1
[364.237484] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[364.238336] Subtest bad-vtotal: SUCCESS (0.076s)
[364.612565] [103/131] (678s left) core_auth (many-magics)
[364.671209] Starting subtest: many-magics
[365.145608] Subtest many-magics: SUCCESS (0.417s)
[365.196076] [104/131] (677s left) i915_drm_fdinfo (memory-info-shared)
[365.257887] Subtest memory-info-shared: SKIP (0.000s)
[365.319086] [105/131] (677s left) gem_exec_schedule (preempt)
[365.389795] Subtest preempt: SKIP (0.000s)
[365.590019] [106/131] (677s left) gem_exec_create (forked)
[365.655405] Starting subtest: forked
[365.656180] Starting dynamic subtest: smem
[385.768388] Dynamic subtest smem: SUCCESS (20.107s)
[385.769765] Subtest forked: SUCCESS (20.109s)
[385.976825] [107/131] (657s left) syncobj_wait (wait-for-submit-complex)
[386.029850] Starting subtest: wait-for-submit-complex
[386.093578] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[386.189174] [108/131] (657s left) gem_userptr_blits (map-fixed-invalidate-busy)
[386.264345] Starting subtest: map-fixed-invalidate-busy
[386.264964] Starting dynamic subtest: gtt
[387.279781] Dynamic subtest gtt: SUCCESS (1.015s)
[387.295424] Starting dynamic subtest: wb
[388.274007] Dynamic subtest wb: SUCCESS (0.992s)
[388.288145] Starting dynamic subtest: wc
[389.257634] Dynamic subtest wc: SUCCESS (0.982s)
[389.271424] Starting dynamic subtest: uc
[390.251911] Dynamic subtest uc: SUCCESS (0.992s)
[390.252822] Subtest map-fixed-invalidate-busy: SUCCESS (3.989s)
[390.384486] [109/131] (652s left) kms_plane_alpha_blend (constant-alpha-max)
[390.753382] Starting subtest: constant-alpha-max
[390.911734] Subtest constant-alpha-max: SKIP (0.160s)
[391.548125] [110/131] (651s left) i915_pm_rpm (sysfs-read)
[403.158422] Subtest sysfs-read: SKIP (0.000s)
[403.385667] [111/131] (640s left) api_intel_bb (intel-bb-blit-x)
[403.450395] Starting subtest: intel-bb-blit-x
[406.383702] Subtest intel-bb-blit-x: SUCCESS (2.932s)
[406.518832] [112/131] (636s left) gem_exec_parallel (userptr)
[406.591458] Starting subtest: userptr
[406.592584] Starting dynamic subtest: rcs0
[408.348998] Dynamic subtest rcs0: SUCCESS (1.757s)
[408.375449] Starting dynamic subtest: bcs0
[410.182819] Dynamic subtest bcs0: SUCCESS (1.831s)
[410.185716] Subtest userptr: SUCCESS (3.592s)
[410.383033] [113/131] (633s left) gem_ctx_shared (q-promotion)
[410.441812] Subtest Q-promotion: SKIP (0.000s)
[410.530382] [114/131] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[410.903825] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[410.905309] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[411.342248] [115/131] (632s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[411.399809] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[411.459725] [116/131] (632s left) kms_cursor_crc (cursor-offscreen-256x85)
[411.827877] Starting subtest: cursor-offscreen-256x85
[411.883204] Subtest cursor-offscreen-256x85: SKIP (0.054s)
[412.329698] [117/131] (631s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[412.390718] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[412.454926] [118/131] (631s left) kms_flip (2x-absolute-wf_vblank)
[412.821735] Starting subtest: 2x-absolute-wf_vblank
[412.822569] Starting dynamic subtest: AB-VGA1-HDMI-A1
[443.265611] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.441s)
[443.268845] Subtest 2x-absolute-wf_vblank: SUCCESS (30.447s)
[443.926255] [119/131] (599s left) perf (buffer-fill)
[444.042332] Subtest buffer-fill: SKIP (0.000s)
[444.110794] [120/131] (599s left) kms_addfb_basic (bad-pitch-128)
[444.167391] Starting subtest: bad-pitch-128
[444.168052] Subtest bad-pitch-128: SUCCESS (0.000s)
[444.909894] [121/131] (599s left) gem_exec_flush (basic-batch-kernel-default-uc)
[444.978642] Starting subtest: basic-batch-kernel-default-uc
[450.627033] Subtest basic-batch-kernel-default-uc: SUCCESS (5.650s)
[450.830696] [122/131] (593s left) syncobj_timeline (wait-all-interrupted)
[450.890959] Starting subtest: wait-all-interrupted
[451.000444] Subtest wait-all-interrupted: SUCCESS (0.109s)
[451.091011] [123/131] (592s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[451.454837] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[451.457562] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[451.891893] [124/131] (592s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[452.258667] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[452.259917] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[452.712039] [125/131] (591s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[452.769145] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[452.833155] [126/131] (591s left) perf (gen12-unprivileged-single-ctx-counters)
[452.939611] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[452.999564] [127/131] (591s left) gem_userptr_blits (relocations)
[453.056738] Starting subtest: relocations
[453.058966] Subtest relocations: SUCCESS (0.001s)
[453.187923] [128/131] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[453.548532] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[453.549910] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[453.985781] [129/131] (590s left) kms_vblank (query-forked-hang)
[454.354531] Starting subtest: query-forked-hang
[454.355572] Starting dynamic subtest: pipe-A-HDMI-A-1
[460.371013] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.017s)
[460.386642] Starting dynamic subtest: pipe-B-HDMI-A-1
[466.372089] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.000s)
[466.372799] Subtest query-forked-hang: SUCCESS (12.022s)
[466.923773] [130/131] (577s left) gem_ringfill (basic-all)
[467.148603] Starting subtest: basic-all
[468.249175] Subtest basic-all: SUCCESS (1.102s)
[468.404739] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[468.407981] [131/131] (576s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[468.769416] Starting subtest: short-flip-before-cursor-toggle
[469.729275] Subtest short-flip-before-cursor-toggle: SUCCESS (0.960s)
[470.282151] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: gem_ctx_engines
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_plane_scaling
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: gem_exercise_blt
results: parsing output: 9/ for test: core_getversion
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: kms_plane_scaling
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_eio
results: parsing output: 25/ for test: kms_async_flips
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_psr2_su
results: parsing output: 28/ for test: gem_exec_schedule
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_basic
results: parsing output: 33/ for test: gem_exec_balancer
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_lease
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: kms_pm_dc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: tools_test
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: gem_mmap_offset
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_vrr
results: parsing output: 48/ for test: gem_pxp
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_chamelium_frames
results: parsing output: 51/ for test: gem_ctx_persistence
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_basic
results: parsing output: 55/ for test: api_intel_allocator
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_pm_freq_api
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: perf
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: sysfs_defaults
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_3d
results: parsing output: 73/ for test: gem_reg_read
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: gem_readwrite
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_caching
results: parsing output: 78/ for test: kms_force_connector_basic
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_fbcon_fbt
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_exec_endless
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_plane_lowres
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_busy
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_draw_crc
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_invalid_mode
results: parsing output: 102/ for test: core_auth
results: parsing output: 103/ for test: i915_drm_fdinfo
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_exec_create
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_plane_alpha_blend
results: parsing output: 109/ for test: i915_pm_rpm
results: parsing output: 110/ for test: api_intel_bb
results: parsing output: 111/ for test: gem_exec_parallel
results: parsing output: 112/ for test: gem_ctx_shared
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_cursor_crc
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: gem_exec_flush
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ringfill
results: parsing output: 130/ for test: kms_cursor_legacy
Done.