[74.637422] Initializing watchdogs
[74.637638]   /dev/watchdog0
[74.658929] [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)
[74.666865] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.670786] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.673795] [001/131] (960s left) gen9_exec_parse (allowed-single)
[74.762500] Subtest allowed-single: SKIP (0.000s)
[74.815070] [002/131] (960s left) gem_ctx_engines (invalid-engines)
[74.880927] Starting subtest: invalid-engines
[74.886563] Subtest invalid-engines: SUCCESS (0.005s)
[75.111204] [003/131] (960s left) syncobj_timeline (invalid-signal-illegal-point)
[75.167506] Starting subtest: invalid-signal-illegal-point
[75.168298] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[75.257260] [004/131] (960s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[75.625983] Starting subtest: plane-upscale-20x20-with-modifiers
[75.626770] Starting dynamic subtest: pipe-A
[75.628818] Dynamic subtest pipe-A: SKIP (0.001s)
[75.638885] Starting dynamic subtest: pipe-B
[75.640888] Dynamic subtest pipe-B: SKIP (0.001s)
[75.642275] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.003s)
[76.072979] [005/131] (959s left) gen9_exec_parse (bb-start-out)
[76.129690] Subtest bb-start-out: SKIP (0.000s)
[76.182643] [006/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[76.562249] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[76.563980] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[76.999592] [007/131] (958s left) kms_cursor_crc (cursor-sliding-32x10)
[77.376444] Starting subtest: cursor-sliding-32x10
[77.438241] Subtest cursor-sliding-32x10: SKIP (0.060s)
[77.871025] [008/131] (957s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[78.248656] Starting subtest: 2x-flip-vs-rmfb-interruptible
[78.250809] Starting dynamic subtest: AB-VGA1-HDMI-A1
[108.617969] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.367s)
[108.619168] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.369s)
[109.267241] [009/131] (926s left) gem_exercise_blt (fast-copy-emit)
[109.333262] Subtest fast-copy-emit: SKIP (0.000s)
[109.391732] [010/131] (926s left) core_getversion (all-cards)
[109.445879] Starting subtest: all-cards
[109.460908] Subtest all-cards: SUCCESS (0.016s)
[109.512894] [011/131] (926s left) i915_query (query-topology-kernel-writes)
[109.564774] Starting subtest: query-topology-kernel-writes
[109.566242] Subtest query-topology-kernel-writes: SKIP (0.000s)
[109.668863] [012/131] (925s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[110.034922] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[110.035898] Starting dynamic subtest: pipe-A
[110.038009] Dynamic subtest pipe-A: SKIP (0.002s)
[110.046396] Starting dynamic subtest: pipe-B
[110.048255] Dynamic subtest pipe-B: SKIP (0.001s)
[110.049397] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s)
[110.460546] [013/131] (925s left) prime_busy (hang)
[110.520938] Starting subtest: hang
[110.521781] Starting dynamic subtest: rcs0
[116.852232] Dynamic subtest rcs0: SUCCESS (6.329s)
[116.860470] Starting dynamic subtest: bcs0
[122.867095] Dynamic subtest bcs0: SUCCESS (6.016s)
[122.876044] Starting dynamic subtest: vcs0
[128.877889] Dynamic subtest vcs0: SUCCESS (6.010s)
[128.878633] Subtest hang: SUCCESS (18.357s)
[128.991161] [014/131] (906s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[129.055092] Starting subtest: y-tiled-ccs-to-y-tiled
[129.055888] Starting dynamic subtest: smem
[129.057744] Dynamic subtest smem: SKIP (0.000s)
[129.059416] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[129.255950] [015/131] (906s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[129.627350] Starting subtest: x-tiled-8bpp-rotate-180
[130.934747] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.306s)
[131.410144] [016/131] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[131.775634] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[131.777023] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[132.208437] [017/131] (903s left) kms_psr (psr-sprite-plane-onoff)
[132.578015] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[132.798644] [018/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[133.172803] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[133.175433] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[133.606029] [019/131] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[133.978065] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[133.979388] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[134.424398] [020/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[134.794741] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[134.795973] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[135.241285] [021/131] (900s left) kms_cursor_crc (cursor-suspend)
[135.605866] Starting subtest: cursor-suspend
[135.606686] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.081929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.017s)
[170.093628] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.098037] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.951s)
[205.098763] Subtest cursor-suspend: SUCCESS (3.972s)
[213.684652] [022/131] (830s left) syncobj_timeline (multi-wait-for-submit-signaled)
[213.771248] Starting subtest: multi-wait-for-submit-signaled
[213.773250] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[213.864012] [023/131] (830s left) perf_pmu (idle-no-semaphores)
[213.926796] Starting subtest: idle-no-semaphores
[213.927647] Starting dynamic subtest: rcs0
[214.468472] Dynamic subtest rcs0: SUCCESS (0.521s)
[214.493150] Starting dynamic subtest: bcs0
[214.998405] Dynamic subtest bcs0: SUCCESS (0.511s)
[215.021842] Starting dynamic subtest: vcs0
[215.532807] Dynamic subtest vcs0: SUCCESS (0.516s)
[215.533886] Subtest idle-no-semaphores: SUCCESS (1.552s)
[215.642344] [024/131] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[216.028904] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[216.030584] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[216.483196] [025/131] (827s left) gem_eio (context-create)
[216.552346] Starting subtest: context-create
[216.576193] Subtest context-create: SUCCESS (0.022s)
[217.360320] [026/131] (826s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[217.740599] Starting subtest: basic-modeset-with-all-modifiers-formats
[217.878236] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[218.011313] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.130s)
[218.032305] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[218.033663] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.013s)
[218.052778] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[218.054278] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.016s)
[218.072737] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XBGR16161616F
[218.074335] Dynamic subtest pipe-A-HDMI-A-1-x-XBGR16161616F: SUCCESS (0.016s)
[218.214314] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (0.465s)
[218.778240] [027/131] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[219.158582] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[221.133848] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.942s)
[221.622979] [028/131] (822s left) kms_psr2_su (frontbuffer-xrgb8888)
[221.681404] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[221.757280] [029/131] (822s left) gem_exec_schedule (out-order)
[221.825932] Subtest out-order: SKIP (0.000s)
[222.027879] [030/131] (822s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[222.408465] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[225.004183] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.567s)
[225.484865] [031/131] (819s left) i915_query (query-topology-coherent-slice-mask)
[225.543289] Starting subtest: query-topology-coherent-slice-mask
[225.545274] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[225.636063] [032/131] (819s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[226.004417] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[226.259671] [033/131] (818s left) gem_basic (multigpu-create-close)
[226.314111] Starting subtest: multigpu-create-close
[226.315612] Subtest multigpu-create-close: SKIP (0.000s)
[226.408913] [034/131] (818s left) gem_exec_balancer (parallel-contexts)
[226.463757] Subtest parallel-contexts: SKIP (0.000s)
[226.561349] [035/131] (818s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[226.941718] Starting subtest: fbcpsr-tiling-linear
[226.943303] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[227.381482] [036/131] (817s left) kms_lease (lease-invalid-plane)
[227.750249] Starting subtest: lease-invalid-plane
[227.750978] Starting dynamic subtest: pipe-A-HDMI-A-1
[227.751632] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[227.764201] Starting dynamic subtest: pipe-B-HDMI-A-1
[227.764954] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[227.765927] Subtest lease-invalid-plane: SUCCESS (0.003s)
[228.188017] [037/131] (816s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[228.569528] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[228.570315] Starting dynamic subtest: AB-VGA1-HDMI-A1
[293.064224] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (64.432s)
[293.067157] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (64.435s)
[293.741195] [038/131] (751s left) kms_pm_dc (dc5-dpms-negative)
[304.848194] Subtest dc5-dpms-negative: SKIP (0.000s)
[304.899443] [039/131] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[305.267952] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[305.269408] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[305.706605] [040/131] (739s left) gem_mmap_gtt (big-bo)
[305.768160] Starting subtest: big-bo
[306.345825] Subtest big-bo: SUCCESS (0.577s)
[306.491096] [041/131] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[306.962993] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[306.967144] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[307.420782] [042/131] (737s left) tools_test (tools_test)
[307.485595] Starting subtest: tools_test
[307.589747] Subtest tools_test: SUCCESS (0.113s)
[307.667265] [043/131] (737s left) kms_atomic_transition (modeset-transition)
[308.031489] Starting subtest: modeset-transition
[308.032169] Starting dynamic subtest: 1x-outputs
[309.012659] Dynamic subtest 1x-outputs: SUCCESS (0.981s)
[309.048679] Subtest modeset-transition: SUCCESS (1.019s)
[309.606839] [044/131] (735s left) gem_mmap_offset (partial-mmap)
[309.663639] Starting subtest: partial-mmap
[309.664378] Starting dynamic subtest: smem0
[309.667749] Dynamic subtest smem0: SUCCESS (0.005s)
[309.668475] Subtest partial-mmap: SUCCESS (0.006s)
[309.783071] [045/131] (735s left) kms_color (legacy-gamma-reset)
[310.141614] Starting subtest: legacy-gamma-reset
[310.142700] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.287307] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.145s)
[310.304351] Starting dynamic subtest: pipe-B-HDMI-A-1
[310.305194] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[310.305954] Subtest legacy-gamma-reset: SUCCESS (0.153s)
[310.839057] [046/131] (734s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[310.905048] Starting subtest: mixed-tiled-to-y-tiled-ccs
[310.905769] Starting dynamic subtest: smem
[310.907309] Dynamic subtest smem: SKIP (0.000s)
[310.908652] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.001s)
[311.105790] [047/131] (734s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[311.478134] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[311.698300] [048/131] (733s left) kms_vrr (flipline)
[312.063314] Starting subtest: flipline
[312.067467] Subtest flipline: SKIP (0.000s)
[312.506703] [049/131] (732s left) gem_pxp (regular-baseline-src-copy-readible)
[315.081945] Starting subtest: regular-baseline-src-copy-readible
[315.083382] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[315.181278] [050/131] (730s left) kms_psr (psr-primary-blt)
[315.543491] Subtest psr-primary-blt: SKIP (0.000s)
[315.771264] [051/131] (729s left) kms_chamelium_frames (dp-crc-fast)
[316.214310] Subtest dp-crc-fast: SKIP (0.000s)
[316.570151] [052/131] (729s left) gem_ctx_persistence (legacy-engines-mixed)
[316.629265] Subtest legacy-engines-mixed: SKIP (0.000s)
[316.682684] [053/131] (729s left) kms_pm_rpm (pm-caching)
[328.275823] Subtest pm-caching: SKIP (0.000s)
[328.517940] [054/131] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[328.894820] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[328.896353] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[329.332919] [055/131] (716s left) syncobj_basic (illegal-fd-to-handle)
[329.388649] Starting subtest: illegal-fd-to-handle
[329.389323] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[329.479175] [056/131] (716s left) api_intel_allocator (fork-simple-once)
[329.533825] Starting subtest: fork-simple-once
[329.558169] Subtest fork-simple-once: SUCCESS (0.025s)
[329.677958] [057/131] (716s left) gem_userptr_blits (unsync-unmap-after-close)
[329.737755] Subtest unsync-unmap-after-close: SKIP (0.000s)
[329.875843] [058/131] (716s left) syncobj_wait (multi-wait-all-signaled)
[329.941394] Starting subtest: multi-wait-all-signaled
[329.943662] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[330.045782] [059/131] (715s left) kms_dsc (dsc-with-output-formats-with-bpc)
[330.409032] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[330.642515] [060/131] (715s left) gem_create (create-ext-cpu-access-big)
[330.814086] Starting subtest: create-ext-cpu-access-big
[330.816273] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[330.909754] [061/131] (715s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[330.967497] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[331.020365] [062/131] (715s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[331.390194] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[331.393278] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[331.827685] [063/131] (714s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[332.190944] Starting subtest: psr-shrfb-scaledprimary
[332.192187] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[332.623097] [064/131] (713s left) i915_pm_freq_api (freq-basic-api)
[332.691454] Subtest freq-basic-api: SKIP (0.000s)
[332.763143] [065/131] (713s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[333.128630] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[333.130668] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[333.570664] [066/131] (712s left) perf (blocking)
[333.725722] Subtest blocking: SKIP (0.000s)
[333.789238] [067/131] (712s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[333.845801] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[333.914207] [068/131] (712s left) sysfs_defaults (readonly)
[333.972694] Starting subtest: readonly
[333.975188] Starting dynamic subtest: vcs0
[333.975882] Dynamic subtest vcs0: SUCCESS (0.001s)
[333.991251] Starting dynamic subtest: bcs0
[333.992896] Dynamic subtest bcs0: SUCCESS (0.001s)
[334.010359] Starting dynamic subtest: rcs0
[334.011699] Dynamic subtest rcs0: SUCCESS (0.000s)
[334.012718] Subtest readonly: SUCCESS (0.007s)
[334.072020] [069/131] (712s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[334.438829] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[334.440185] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[334.880986] [070/131] (711s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[334.940292] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[335.048634] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[335.149195] [071/131] (711s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[335.522733] Starting subtest: x-tiled-32bpp-rotate-180
[336.964301] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.442s)
[337.430118] [072/131] (709s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[337.800980] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[337.802386] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[338.244700] [073/131] (708s left) kms_3d
[342.115837] [074/131] (704s left) gem_reg_read (bad-register)
[342.220294] Starting subtest: bad-register
[342.221033] Subtest bad-register: SUCCESS (0.000s)
[342.311123] [075/131] (704s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[342.679844] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[342.694067] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[343.115642] [076/131] (703s left) gem_readwrite (new-obj)
[343.195532] Starting subtest: new-obj
[343.197265] Subtest new-obj: SUCCESS (0.000s)
[343.297411] [077/131] (703s left) kms_psr (pr-suspend)
[343.661820] Subtest pr-suspend: SKIP (0.000s)
[343.892122] [078/131] (703s left) gem_caching (writes)
[343.953397] Starting subtest: writes
[346.965473] Subtest writes: SUCCESS (3.013s)
[347.078302] [079/131] (699s left) kms_force_connector_basic (force-load-detect)
[347.149041] Starting subtest: force-load-detect
[347.382246] Subtest force-load-detect: SUCCESS (0.234s)
[347.826507] [080/131] (699s left) syncobj_timeline (32bits-limit)
[347.899789] Starting subtest: 32bits-limit
[347.901858] Subtest 32bits-limit: SUCCESS (0.002s)
[347.991606] [081/131] (699s left) gem_userptr_blits (coherency-unsync)
[348.049706] Subtest coherency-unsync: SKIP (0.000s)
[348.178317] [082/131] (698s left) gem_mmap_offset (bad-flags)
[348.234767] Starting subtest: bad-flags
[348.235473] Subtest bad-flags: SUCCESS (0.000s)
[348.340629] [083/131] (698s left) kms_fbcon_fbt (fbc)
[348.399499] Starting subtest: fbc
[351.843376] Subtest fbc: SUCCESS (3.443s)
[351.915924] [084/131] (695s left) kms_cursor_crc (cursor-random-256x256)
[352.288740] Starting subtest: cursor-random-256x256
[352.292028] Starting dynamic subtest: pipe-A-HDMI-A-1
[355.976911] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.683s)
[356.019717] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.714634] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.708s)
[359.715328] Subtest cursor-random-256x256: SUCCESS (7.425s)
[360.268081] [085/131] (687s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[360.327465] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[360.377177] [086/131] (687s left) gem_exec_params (invalid-bsd-ring)
[360.435223] Starting subtest: invalid-bsd-ring
[360.436128] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[360.550021] [087/131] (686s left) gem_exec_endless (dispatch)
[360.609348] Subtest dispatch: SKIP (0.000s)
[360.703955] [088/131] (686s left) kms_psr (fbc-psr-no-drrs)
[361.062286] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[361.291910] [089/131] (686s left) gem_userptr_blits (sync-overlap)
[361.362771] Starting subtest: sync-overlap
[361.363770] Subtest sync-overlap: SUCCESS (0.001s)
[361.481289] [090/131] (686s left) kms_plane_lowres (tiling-y)
[361.840552] Starting subtest: tiling-y
[361.841791] Subtest tiling-y: SKIP (0.000s)
[362.281987] [091/131] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[362.652198] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[362.653482] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[363.098233] [092/131] (684s left) kms_busy (extended-pageflip-hang-oldfb)
[363.461166] Starting subtest: extended-pageflip-hang-oldfb
[363.461930] Starting dynamic subtest: pipe-A
[363.645711] Dynamic subtest pipe-A: SUCCESS (0.183s)
[363.660622] Starting dynamic subtest: pipe-B
[363.916769] Dynamic subtest pipe-B: SUCCESS (0.269s)
[363.917536] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.457s)
[364.479168] [093/131] (683s left) gem_lmem_swapping (random-engines)
[364.541317] Subtest random-engines: SKIP (0.000s)
[364.605160] [094/131] (683s left) perf (gen8-unprivileged-single-ctx-counters)
[364.713631] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[364.777217] [095/131] (683s left) kms_chamelium_hpd (dp-hpd-storm)
[365.212577] Subtest dp-hpd-storm: SKIP (0.000s)
[365.556113] [096/131] (682s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[365.618252] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[365.618955] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[365.710042] [097/131] (682s left) gem_exec_schedule (u-semaphore-codependency)
[365.776928] Subtest u-semaphore-codependency: SKIP (0.000s)
[365.975989] [098/131] (682s left) kms_draw_crc (draw-method-mmap-cpu)
[366.337747] Starting subtest: draw-method-mmap-cpu
[366.338524] Starting dynamic subtest: xrgb8888-untiled
[366.608404] Dynamic subtest xrgb8888-untiled: SUCCESS (0.270s)
[366.624926] Starting dynamic subtest: rgb565-untiled
[366.891217] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[366.910412] Starting dynamic subtest: xrgb2101010-untiled
[367.207285] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s)
[367.226886] Starting dynamic subtest: xbgr16161616f-untiled
[367.540538] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.329s)
[367.556482] Starting dynamic subtest: xrgb8888-xtiled
[367.723169] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.181s)
[367.741868] Starting dynamic subtest: rgb565-xtiled
[367.889659] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[367.905596] Starting dynamic subtest: xrgb2101010-xtiled
[368.072477] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[368.088179] Starting dynamic subtest: xbgr16161616f-xtiled
[368.272017] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.197s)
[368.275150] Subtest draw-method-mmap-cpu: SUCCESS (1.935s)
[368.738782] [099/131] (679s left) kms_prop_blob (invalid-get-prop-any)
[368.793167] Starting subtest: invalid-get-prop-any
[368.793787] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[368.905088] [100/131] (679s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[369.267327] Starting subtest: addfb25-y-tiled-legacy
[369.268105] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[369.710942] [101/131] (678s left) gem_spin_batch (spin-all)
[369.779908] Starting subtest: spin-all
[369.783038] Subtest spin-all: SUCCESS (0.003s)
[369.986281] [102/131] (678s left) kms_invalid_mode (bad-vtotal)
[370.350448] Starting subtest: bad-vtotal
[370.351167] Starting dynamic subtest: pipe-A-HDMI-A-1
[370.418950] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.066s)
[370.436157] Starting dynamic subtest: pipe-B-HDMI-A-1
[370.437305] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[370.438310] Subtest bad-vtotal: SUCCESS (0.071s)
[370.981990] [103/131] (677s left) core_auth (many-magics)
[371.038969] Starting subtest: many-magics
[371.426789] Subtest many-magics: SUCCESS (0.389s)
[371.528838] [104/131] (676s left) i915_drm_fdinfo (memory-info-shared)
[371.592531] Subtest memory-info-shared: SKIP (0.000s)
[371.657535] [105/131] (676s left) gem_exec_schedule (preempt)
[371.728154] Subtest preempt: SKIP (0.000s)
[371.924957] [106/131] (676s left) gem_exec_create (forked)
[371.991871] Starting subtest: forked
[371.992741] Starting dynamic subtest: smem
[392.098243] Dynamic subtest smem: SUCCESS (20.100s)
[392.101503] Subtest forked: SUCCESS (20.102s)
[392.308619] [107/131] (656s left) syncobj_wait (wait-for-submit-complex)
[392.365885] Starting subtest: wait-for-submit-complex
[392.429363] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[392.529271] [108/131] (655s left) gem_userptr_blits (map-fixed-invalidate-busy)
[392.600004] Starting subtest: map-fixed-invalidate-busy
[392.600758] Starting dynamic subtest: gtt
[393.617958] Dynamic subtest gtt: SUCCESS (1.018s)
[393.632481] Starting dynamic subtest: wb
[394.618180] Dynamic subtest wb: SUCCESS (0.998s)
[394.632887] Starting dynamic subtest: wc
[395.608582] Dynamic subtest wc: SUCCESS (0.989s)
[395.622504] Starting dynamic subtest: uc
[396.603929] Dynamic subtest uc: SUCCESS (0.994s)
[396.604773] Subtest map-fixed-invalidate-busy: SUCCESS (4.005s)
[396.736824] [109/131] (651s left) kms_plane_alpha_blend (constant-alpha-max)
[397.098749] Starting subtest: constant-alpha-max
[397.262595] Subtest constant-alpha-max: SKIP (0.159s)
[397.898106] [110/131] (650s left) i915_pm_rpm (sysfs-read)
[409.505342] Subtest sysfs-read: SKIP (0.000s)
[409.757835] [111/131] (638s left) api_intel_bb (intel-bb-blit-x)
[409.835171] Starting subtest: intel-bb-blit-x
[412.772133] Subtest intel-bb-blit-x: SUCCESS (2.936s)
[412.906911] [112/131] (635s left) gem_exec_parallel (userptr)
[412.968635] Starting subtest: userptr
[412.969555] Starting dynamic subtest: rcs0
[414.699231] Dynamic subtest rcs0: SUCCESS (1.729s)
[414.718295] Starting dynamic subtest: bcs0
[416.400858] Dynamic subtest bcs0: SUCCESS (1.698s)
[416.402133] Subtest userptr: SUCCESS (3.432s)
[416.600778] [113/131] (632s left) gem_ctx_shared (q-promotion)
[416.659440] Subtest Q-promotion: SKIP (0.000s)
[416.750943] [114/131] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[417.113383] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[417.114607] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[417.565690] [115/131] (631s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[417.621651] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[417.699314] [116/131] (631s left) kms_cursor_crc (cursor-offscreen-256x85)
[418.069213] Starting subtest: cursor-offscreen-256x85
[418.126366] Subtest cursor-offscreen-256x85: SKIP (0.055s)
[418.567312] [117/131] (630s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[418.625033] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[418.688930] [118/131] (630s left) kms_flip (2x-absolute-wf_vblank)
[419.050698] Starting subtest: 2x-absolute-wf_vblank
[419.051535] Starting dynamic subtest: AB-VGA1-HDMI-A1
[449.497393] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.449s)
[449.500653] Subtest 2x-absolute-wf_vblank: SUCCESS (30.454s)
[450.155000] [119/131] (598s left) perf (buffer-fill)
[450.270334] Subtest buffer-fill: SKIP (0.000s)
[450.336246] [120/131] (598s left) kms_addfb_basic (bad-pitch-128)
[450.392756] Starting subtest: bad-pitch-128
[450.393522] Subtest bad-pitch-128: SUCCESS (0.000s)
[451.138662] [121/131] (598s left) gem_exec_flush (basic-batch-kernel-default-uc)
[451.207107] Starting subtest: basic-batch-kernel-default-uc
[456.939963] Subtest basic-batch-kernel-default-uc: SUCCESS (5.734s)
[457.141148] [122/131] (592s left) syncobj_timeline (wait-all-interrupted)
[457.197127] Starting subtest: wait-all-interrupted
[457.304542] Subtest wait-all-interrupted: SUCCESS (0.107s)
[457.404073] [123/131] (591s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[457.767685] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[457.769259] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[458.205130] [124/131] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[458.572281] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[458.573969] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[459.017656] [125/131] (590s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[459.080990] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[459.149872] [126/131] (590s left) perf (gen12-unprivileged-single-ctx-counters)
[459.250753] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[459.309731] [127/131] (590s left) gem_userptr_blits (relocations)
[459.367866] Starting subtest: relocations
[459.368564] Subtest relocations: SUCCESS (0.001s)
[459.517013] [128/131] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[459.885288] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[459.887238] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[460.334741] [129/131] (589s left) kms_vblank (query-forked-hang)
[460.696805] Starting subtest: query-forked-hang
[460.697898] Starting dynamic subtest: pipe-A-HDMI-A-1
[466.467064] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.771s)
[466.485168] Starting dynamic subtest: pipe-B-HDMI-A-1
[472.495206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.027s)
[472.496050] Subtest query-forked-hang: SUCCESS (11.804s)
[473.052394] [130/131] (576s left) gem_ringfill (basic-all)
[473.283540] Starting subtest: basic-all
[474.382880] Subtest basic-all: SUCCESS (1.098s)
[474.503526] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[474.507627] [131/131] (575s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[474.871188] Starting subtest: short-flip-before-cursor-toggle
[475.826336] Subtest short-flip-before-cursor-toggle: SUCCESS (0.955s)
[476.377184] 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.