[68.947692] Initializing watchdogs
[68.947813]   /dev/watchdog0
[68.970689] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[68.978800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.982417] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.985423] [001/131] (960s left) gen9_exec_parse (allowed-single)
[69.060281] Subtest allowed-single: SKIP (0.000s)
[69.108538] [002/131] (960s left) gem_ctx_engines (invalid-engines)
[69.171894] Starting subtest: invalid-engines
[69.178487] Subtest invalid-engines: SUCCESS (0.006s)
[69.409810] [003/131] (960s left) syncobj_timeline (invalid-signal-illegal-point)
[69.464110] Starting subtest: invalid-signal-illegal-point
[69.464739] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[69.546638] [004/131] (960s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[69.913901] Starting subtest: plane-upscale-20x20-with-modifiers
[69.914696] Starting dynamic subtest: pipe-A
[69.916308] Dynamic subtest pipe-A: SKIP (0.001s)
[69.926527] Starting dynamic subtest: pipe-B
[69.928218] Dynamic subtest pipe-B: SKIP (0.001s)
[69.929230] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.003s)
[70.346904] [005/131] (959s left) gen9_exec_parse (bb-start-out)
[70.402718] Subtest bb-start-out: SKIP (0.000s)
[70.461822] [006/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[70.837347] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[70.839431] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[71.263358] [007/131] (958s left) kms_cursor_crc (cursor-sliding-32x10)
[71.643926] Starting subtest: cursor-sliding-32x10
[71.702592] Subtest cursor-sliding-32x10: SKIP (0.058s)
[72.134324] [008/131] (957s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[72.502685] Starting subtest: 2x-flip-vs-rmfb-interruptible
[72.504354] Starting dynamic subtest: AB-VGA1-HDMI-A1
[102.877188] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.361s)
[102.878363] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.363s)
[103.530105] [009/131] (926s left) gem_exercise_blt (fast-copy-emit)
[103.590525] Subtest fast-copy-emit: SKIP (0.000s)
[103.641236] [010/131] (926s left) core_getversion (all-cards)
[103.691735] Starting subtest: all-cards
[103.706040] Subtest all-cards: SUCCESS (0.015s)
[103.764966] [011/131] (926s left) i915_query (query-topology-kernel-writes)
[103.822885] Starting subtest: query-topology-kernel-writes
[103.824171] Subtest query-topology-kernel-writes: SKIP (0.000s)
[103.917824] [012/131] (926s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[104.278519] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[104.279454] Starting dynamic subtest: pipe-A
[104.281315] Dynamic subtest pipe-A: SKIP (0.001s)
[104.292045] Starting dynamic subtest: pipe-B
[104.294494] Dynamic subtest pipe-B: SKIP (0.001s)
[104.295913] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.003s)
[104.710505] [013/131] (925s left) prime_busy (hang)
[104.768276] Starting subtest: hang
[104.768843] Starting dynamic subtest: rcs0
[110.838384] Dynamic subtest rcs0: SUCCESS (6.068s)
[110.847883] Starting dynamic subtest: bcs0
[116.852219] Dynamic subtest bcs0: SUCCESS (6.012s)
[116.860949] Starting dynamic subtest: vcs0
[122.872532] Dynamic subtest vcs0: SUCCESS (6.020s)
[122.873919] Subtest hang: SUCCESS (18.103s)
[122.996225] [014/131] (907s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[123.058924] Starting subtest: y-tiled-ccs-to-y-tiled
[123.060040] Starting dynamic subtest: smem
[123.061614] Dynamic subtest smem: SKIP (0.000s)
[123.062631] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[123.262028] [015/131] (906s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[123.639142] Starting subtest: x-tiled-8bpp-rotate-180
[124.935368] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.296s)
[125.411102] [016/131] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[125.784238] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[125.787161] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[126.246152] [017/131] (903s left) kms_psr (psr-sprite-plane-onoff)
[126.610739] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[126.832985] [018/131] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[127.199470] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[127.200567] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[127.636818] [019/131] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[128.007324] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[128.008585] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[128.470642] [020/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[128.842459] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[128.843548] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[129.271418] [021/131] (901s left) kms_cursor_crc (cursor-suspend)
[129.641802] Starting subtest: cursor-suspend
[129.642949] Starting dynamic subtest: pipe-A-HDMI-A-1
[166.229151] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.828s)
[166.240592] Starting dynamic subtest: pipe-B-HDMI-A-1
[202.283908] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.384s)
[202.288122] Subtest cursor-suspend: SUCCESS (10.215s)
[207.353005] [022/131] (828s left) syncobj_timeline (multi-wait-for-submit-signaled)
[207.414346] Starting subtest: multi-wait-for-submit-signaled
[207.415823] Subtest multi-wait-for-submit-signaled: SUCCESS (0.002s)
[207.515912] [023/131] (827s left) perf_pmu (idle-no-semaphores)
[207.569953] Starting subtest: idle-no-semaphores
[207.570667] Starting dynamic subtest: rcs0
[208.092464] Dynamic subtest rcs0: SUCCESS (0.522s)
[208.117108] Starting dynamic subtest: bcs0
[208.609785] Dynamic subtest bcs0: SUCCESS (0.516s)
[208.633366] Starting dynamic subtest: vcs0
[209.129189] Dynamic subtest vcs0: SUCCESS (0.518s)
[209.130342] Subtest idle-no-semaphores: SUCCESS (1.559s)
[209.222499] [024/131] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[209.590956] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[209.591911] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[210.042748] [025/131] (825s left) gem_eio (context-create)
[210.104277] Starting subtest: context-create
[210.130439] Subtest context-create: SUCCESS (0.025s)
[210.881897] [026/131] (824s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[211.244341] Starting subtest: basic-modeset-with-all-modifiers-formats
[211.386194] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[211.514592] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.128s)
[211.530716] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[211.531727] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.011s)
[211.548628] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[211.549791] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.016s)
[211.566574] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XBGR16161616F
[211.567683] Dynamic subtest pipe-A-HDMI-A-1-x-XBGR16161616F: SUCCESS (0.016s)
[211.710983] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (0.468s)
[212.268505] [027/131] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[212.638185] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[214.617201] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.979s)
[215.093566] [028/131] (820s left) kms_psr2_su (frontbuffer-xrgb8888)
[215.152134] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[215.208155] [029/131] (820s left) gem_exec_schedule (out-order)
[215.272549] Subtest out-order: SKIP (0.000s)
[215.462636] [030/131] (820s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[215.829608] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[218.393015] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.563s)
[218.875789] [031/131] (817s left) i915_query (query-topology-coherent-slice-mask)
[218.930911] Starting subtest: query-topology-coherent-slice-mask
[218.932274] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[219.020908] [032/131] (816s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[219.385839] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[219.633596] [033/131] (816s left) gem_basic (multigpu-create-close)
[219.687420] Starting subtest: multigpu-create-close
[219.688528] Subtest multigpu-create-close: SKIP (0.000s)
[219.772479] [034/131] (816s left) gem_exec_balancer (parallel-contexts)
[219.828088] Subtest parallel-contexts: SKIP (0.000s)
[219.919969] [035/131] (816s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[220.288444] Starting subtest: fbcpsr-tiling-linear
[220.289454] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[220.722148] [036/131] (815s left) kms_lease (lease-invalid-plane)
[221.085259] Starting subtest: lease-invalid-plane
[221.085737] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.086411] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[221.099114] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.099674] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[221.100227] Subtest lease-invalid-plane: SUCCESS (0.003s)
[221.518974] [037/131] (814s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[221.885165] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[221.885842] Starting dynamic subtest: AB-VGA1-HDMI-A1
[252.609601] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.723s)
[252.612046] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (30.727s)
[253.262148] [038/131] (782s left) kms_pm_dc (dc5-dpms-negative)
[264.362686] Subtest dc5-dpms-negative: SKIP (0.000s)
[264.412457] [039/131] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[264.781974] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[264.782897] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[265.232909] [040/131] (771s left) gem_mmap_gtt (big-bo)
[265.287094] Starting subtest: big-bo
[265.825627] Subtest big-bo: SUCCESS (0.536s)
[265.973890] [041/131] (770s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[266.428385] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[266.430692] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[266.900899] [042/131] (769s left) tools_test (tools_test)
[266.962817] Starting subtest: tools_test
[267.076913] Subtest tools_test: SUCCESS (0.119s)
[267.151135] [043/131] (769s left) kms_atomic_transition (modeset-transition)
[267.511444] Starting subtest: modeset-transition
[267.512088] Starting dynamic subtest: 1x-outputs
[268.477317] Dynamic subtest 1x-outputs: SUCCESS (0.966s)
[268.513392] Subtest modeset-transition: SUCCESS (1.002s)
[269.062254] [044/131] (767s left) gem_mmap_offset (partial-mmap)
[269.115215] Starting subtest: partial-mmap
[269.115790] Starting dynamic subtest: smem0
[269.120769] Dynamic subtest smem0: SUCCESS (0.005s)
[269.121323] Subtest partial-mmap: SUCCESS (0.006s)
[269.243981] [045/131] (767s left) kms_color (legacy-gamma-reset)
[269.604708] Starting subtest: legacy-gamma-reset
[269.605453] Starting dynamic subtest: pipe-A-HDMI-A-1
[269.749442] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s)
[269.763882] Starting dynamic subtest: pipe-B-HDMI-A-1
[269.764535] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[269.765132] Subtest legacy-gamma-reset: SUCCESS (0.152s)
[270.303183] [046/131] (766s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[270.368578] Starting subtest: mixed-tiled-to-y-tiled-ccs
[270.369164] Starting dynamic subtest: smem
[270.370461] Dynamic subtest smem: SKIP (0.000s)
[270.371891] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.001s)
[270.567599] [047/131] (766s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[270.928393] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[271.177189] [048/131] (765s left) kms_vrr (flipline)
[271.543577] Starting subtest: flipline
[271.545069] Subtest flipline: SKIP (0.000s)
[271.982010] [049/131] (764s left) gem_pxp (regular-baseline-src-copy-readible)
[274.547974] Starting subtest: regular-baseline-src-copy-readible
[274.549743] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[274.653818] [050/131] (762s left) kms_psr (psr-primary-blt)
[275.011234] Subtest psr-primary-blt: SKIP (0.000s)
[275.233241] [051/131] (761s left) kms_chamelium_frames (dp-crc-fast)
[275.680252] Subtest dp-crc-fast: SKIP (0.000s)
[276.034414] [052/131] (760s left) gem_ctx_persistence (legacy-engines-mixed)
[276.089502] Subtest legacy-engines-mixed: SKIP (0.000s)
[276.155275] [053/131] (760s left) kms_pm_rpm (pm-caching)
[287.752493] Subtest pm-caching: SKIP (0.000s)
[287.977014] [054/131] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[288.346750] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[288.347681] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[288.786273] [055/131] (748s left) syncobj_basic (illegal-fd-to-handle)
[288.843142] Starting subtest: illegal-fd-to-handle
[288.843615] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[288.935553] [056/131] (748s left) api_intel_allocator (fork-simple-once)
[288.993446] Starting subtest: fork-simple-once
[289.018664] Subtest fork-simple-once: SUCCESS (0.026s)
[289.146693] [057/131] (748s left) gem_userptr_blits (unsync-unmap-after-close)
[289.207283] Subtest unsync-unmap-after-close: SKIP (0.000s)
[289.349436] [058/131] (747s left) syncobj_wait (multi-wait-all-signaled)
[289.411418] Starting subtest: multi-wait-all-signaled
[289.412068] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[289.499909] [059/131] (747s left) kms_dsc (dsc-with-output-formats-with-bpc)
[289.868762] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[290.092879] [060/131] (747s left) gem_create (create-ext-cpu-access-big)
[290.263333] Starting subtest: create-ext-cpu-access-big
[290.265003] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[290.364978] [061/131] (747s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[290.419470] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[290.477209] [062/131] (746s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[290.843457] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[290.844754] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[291.281900] [063/131] (746s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[291.647158] Starting subtest: psr-shrfb-scaledprimary
[291.648190] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[292.095063] [064/131] (745s left) i915_pm_freq_api (freq-basic-api)
[292.149671] Subtest freq-basic-api: SKIP (0.000s)
[292.202592] [065/131] (745s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[292.564218] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[292.565423] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[293.007904] [066/131] (744s left) perf (blocking)
[293.147939] Subtest blocking: SKIP (0.000s)
[293.200068] [067/131] (744s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[293.251447] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[293.319990] [068/131] (744s left) sysfs_defaults (readonly)
[293.377405] Starting subtest: readonly
[293.377910] Starting dynamic subtest: vcs0
[293.378418] Dynamic subtest vcs0: SUCCESS (0.000s)
[293.396628] Starting dynamic subtest: bcs0
[293.397643] Dynamic subtest bcs0: SUCCESS (0.001s)
[293.420153] Starting dynamic subtest: rcs0
[293.421346] Dynamic subtest rcs0: SUCCESS (0.001s)
[293.422241] Subtest readonly: SUCCESS (0.006s)
[293.471108] [069/131] (744s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[293.837869] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[293.839191] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[294.273902] [070/131] (743s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[294.333162] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[294.437388] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[294.538175] [071/131] (743s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[294.910086] Starting subtest: x-tiled-32bpp-rotate-180
[296.352503] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.443s)
[296.835048] [072/131] (741s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[297.197466] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[297.199883] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[297.653159] [073/131] (740s left) kms_3d
[301.475186] [074/131] (736s left) gem_reg_read (bad-register)
[301.531541] Starting subtest: bad-register
[301.532185] Subtest bad-register: SUCCESS (0.000s)
[301.620990] [075/131] (736s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[301.992423] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[301.993556] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[302.433207] [076/131] (735s left) gem_readwrite (new-obj)
[302.486491] Starting subtest: new-obj
[302.487758] Subtest new-obj: SUCCESS (0.000s)
[302.604880] [077/131] (735s left) kms_psr (pr-suspend)
[302.968105] Subtest pr-suspend: SKIP (0.000s)
[303.192401] [078/131] (735s left) gem_caching (writes)
[303.249263] Starting subtest: writes
[306.266442] Subtest writes: SUCCESS (3.018s)
[306.391870] [079/131] (731s left) kms_force_connector_basic (force-load-detect)
[306.459240] Starting subtest: force-load-detect
[306.675178] Subtest force-load-detect: SUCCESS (0.216s)
[307.113314] [080/131] (731s left) syncobj_timeline (32bits-limit)
[307.170597] Starting subtest: 32bits-limit
[307.172399] Subtest 32bits-limit: SUCCESS (0.001s)
[307.277952] [081/131] (731s left) gem_userptr_blits (coherency-unsync)
[307.339046] Subtest coherency-unsync: SKIP (0.000s)
[307.485828] [082/131] (730s left) gem_mmap_offset (bad-flags)
[307.539443] Starting subtest: bad-flags
[307.540288] Subtest bad-flags: SUCCESS (0.000s)
[307.652438] [083/131] (730s left) kms_fbcon_fbt (fbc)
[307.710414] Starting subtest: fbc
[311.144563] Subtest fbc: SUCCESS (3.434s)
[311.197931] [084/131] (727s left) kms_cursor_crc (cursor-random-256x256)
[311.562499] Starting subtest: cursor-random-256x256
[311.564944] Starting dynamic subtest: pipe-A-HDMI-A-1
[315.243202] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.677s)
[315.299716] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.979669] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.691s)
[318.980462] Subtest cursor-random-256x256: SUCCESS (7.417s)
[319.567236] [085/131] (719s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[319.623071] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[319.678388] [086/131] (718s left) gem_exec_params (invalid-bsd-ring)
[319.732292] Starting subtest: invalid-bsd-ring
[319.732730] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[319.847134] [087/131] (718s left) gem_exec_endless (dispatch)
[319.899792] Subtest dispatch: SKIP (0.000s)
[320.006421] [088/131] (718s left) kms_psr (fbc-psr-no-drrs)
[320.368074] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[320.592958] [089/131] (718s left) gem_userptr_blits (sync-overlap)
[320.664472] Starting subtest: sync-overlap
[320.664947] Subtest sync-overlap: SUCCESS (0.000s)
[320.783122] [090/131] (718s left) kms_plane_lowres (tiling-y)
[321.149363] Starting subtest: tiling-y
[321.150499] Subtest tiling-y: SKIP (0.000s)
[321.585678] [091/131] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[321.950849] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[321.951910] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[322.398033] [092/131] (716s left) kms_busy (extended-pageflip-hang-oldfb)
[322.762547] Starting subtest: extended-pageflip-hang-oldfb
[322.763092] Starting dynamic subtest: pipe-A
[322.944312] Dynamic subtest pipe-A: SUCCESS (0.180s)
[322.958575] Starting dynamic subtest: pipe-B
[323.215486] Dynamic subtest pipe-B: SUCCESS (0.269s)
[323.216004] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.455s)
[323.796821] [093/131] (715s left) gem_lmem_swapping (random-engines)
[323.859667] Subtest random-engines: SKIP (0.000s)
[323.911022] [094/131] (715s left) perf (gen8-unprivileged-single-ctx-counters)
[324.020020] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[324.083451] [095/131] (715s left) kms_chamelium_hpd (dp-hpd-storm)
[324.519167] Subtest dp-hpd-storm: SKIP (0.000s)
[324.855507] [096/131] (714s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[324.909628] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[324.910445] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[325.014522] [097/131] (714s left) gem_exec_schedule (u-semaphore-codependency)
[325.084247] Subtest u-semaphore-codependency: SKIP (0.000s)
[325.278143] [098/131] (713s left) kms_draw_crc (draw-method-mmap-cpu)
[325.638586] Starting subtest: draw-method-mmap-cpu
[325.640304] Starting dynamic subtest: xrgb8888-untiled
[325.928499] Dynamic subtest xrgb8888-untiled: SUCCESS (0.289s)
[325.946859] Starting dynamic subtest: rgb565-untiled
[326.212108] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[326.227578] Starting dynamic subtest: xrgb2101010-untiled
[326.510550] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.295s)
[326.527541] Starting dynamic subtest: xbgr16161616f-untiled
[326.860207] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.347s)
[326.876529] Starting dynamic subtest: xrgb8888-xtiled
[327.043393] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.180s)
[327.059419] Starting dynamic subtest: rgb565-xtiled
[327.209468] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[327.224993] Starting dynamic subtest: xrgb2101010-xtiled
[327.393994] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[327.410535] Starting dynamic subtest: xbgr16161616f-xtiled
[327.608962] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.213s)
[327.610096] Subtest draw-method-mmap-cpu: SUCCESS (1.971s)
[328.102527] [099/131] (711s left) kms_prop_blob (invalid-get-prop-any)
[328.155695] Starting subtest: invalid-get-prop-any
[328.156286] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[328.254432] [100/131] (711s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[328.611925] Starting subtest: addfb25-y-tiled-legacy
[328.612403] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[329.058072] [101/131] (710s left) gem_spin_batch (spin-all)
[329.125595] Starting subtest: spin-all
[329.128094] Subtest spin-all: SUCCESS (0.003s)
[329.338205] [102/131] (710s left) kms_invalid_mode (bad-vtotal)
[329.705788] Starting subtest: bad-vtotal
[329.706396] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.786586] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.080s)
[329.801854] Starting dynamic subtest: pipe-B-HDMI-A-1
[329.802523] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[329.803085] Subtest bad-vtotal: SUCCESS (0.085s)
[330.190509] [103/131] (709s left) core_auth (many-magics)
[330.247503] Starting subtest: many-magics
[330.638103] Subtest many-magics: SUCCESS (0.391s)
[330.740669] [104/131] (708s left) i915_drm_fdinfo (memory-info-shared)
[330.798462] Subtest memory-info-shared: SKIP (0.000s)
[330.866375] [105/131] (708s left) gem_exec_schedule (preempt)
[330.933567] Subtest preempt: SKIP (0.000s)
[331.131466] [106/131] (708s left) gem_exec_create (forked)
[331.192565] Starting subtest: forked
[331.193400] Starting dynamic subtest: smem
[351.297396] Dynamic subtest smem: SUCCESS (20.104s)
[351.300426] Subtest forked: SUCCESS (20.106s)
[351.512218] [107/131] (688s left) syncobj_wait (wait-for-submit-complex)
[351.565129] Starting subtest: wait-for-submit-complex
[351.628604] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[351.722997] [108/131] (688s left) gem_userptr_blits (map-fixed-invalidate-busy)
[351.795720] Starting subtest: map-fixed-invalidate-busy
[351.796386] Starting dynamic subtest: gtt
[352.810742] Dynamic subtest gtt: SUCCESS (1.014s)
[352.828533] Starting dynamic subtest: wb
[353.812003] Dynamic subtest wb: SUCCESS (1.000s)
[353.829673] Starting dynamic subtest: wc
[354.813401] Dynamic subtest wc: SUCCESS (0.999s)
[354.828587] Starting dynamic subtest: uc
[355.812352] Dynamic subtest uc: SUCCESS (0.997s)
[355.813132] Subtest map-fixed-invalidate-busy: SUCCESS (4.018s)
[355.947473] [109/131] (683s left) kms_plane_alpha_blend (constant-alpha-max)
[356.309491] Starting subtest: constant-alpha-max
[356.475234] Subtest constant-alpha-max: SKIP (0.166s)
[357.092845] [110/131] (682s left) i915_pm_rpm (sysfs-read)
[368.692450] Subtest sysfs-read: SKIP (0.000s)
[368.915443] [111/131] (671s left) api_intel_bb (intel-bb-blit-x)
[368.969781] Starting subtest: intel-bb-blit-x
[371.954422] Subtest intel-bb-blit-x: SUCCESS (2.985s)
[372.082913] [112/131] (667s left) gem_exec_parallel (userptr)
[372.153091] Starting subtest: userptr
[372.153904] Starting dynamic subtest: rcs0
[373.879326] Dynamic subtest rcs0: SUCCESS (1.725s)
[373.902060] Starting dynamic subtest: bcs0
[375.382520] Dynamic subtest bcs0: SUCCESS (1.500s)
[375.385768] Subtest userptr: SUCCESS (3.230s)
[375.591806] [113/131] (664s left) gem_ctx_shared (q-promotion)
[375.655436] Subtest Q-promotion: SKIP (0.000s)
[375.738131] [114/131] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[376.098492] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[376.099891] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[376.538518] [115/131] (663s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[376.591956] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[376.649596] [116/131] (663s left) kms_cursor_crc (cursor-offscreen-256x85)
[377.013562] Starting subtest: cursor-offscreen-256x85
[377.076688] Subtest cursor-offscreen-256x85: SKIP (0.061s)
[377.521647] [117/131] (662s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[377.575714] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[377.636040] [118/131] (662s left) kms_flip (2x-absolute-wf_vblank)
[377.996511] Starting subtest: 2x-absolute-wf_vblank
[377.997333] Starting dynamic subtest: AB-VGA1-HDMI-A1
[408.427027] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.427s)
[408.429399] Subtest 2x-absolute-wf_vblank: SUCCESS (30.431s)
[409.115092] [119/131] (631s left) perf (buffer-fill)
[409.219852] Subtest buffer-fill: SKIP (0.000s)
[409.277805] [120/131] (631s left) kms_addfb_basic (bad-pitch-128)
[409.329932] Starting subtest: bad-pitch-128
[409.330524] Subtest bad-pitch-128: SUCCESS (0.000s)
[410.080961] [121/131] (630s left) gem_exec_flush (basic-batch-kernel-default-uc)
[410.146896] Starting subtest: basic-batch-kernel-default-uc
[415.846454] Subtest basic-batch-kernel-default-uc: SUCCESS (5.699s)
[416.052090] [122/131] (624s left) syncobj_timeline (wait-all-interrupted)
[416.108451] Starting subtest: wait-all-interrupted
[416.213212] Subtest wait-all-interrupted: SUCCESS (0.105s)
[416.301784] [123/131] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[416.663567] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[416.664678] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[417.119412] [124/131] (623s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[417.481481] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[417.482502] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[417.928357] [125/131] (622s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[417.984359] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[418.044627] [126/131] (622s left) perf (gen12-unprivileged-single-ctx-counters)
[418.147808] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[418.210644] [127/131] (622s left) gem_userptr_blits (relocations)
[418.269828] Starting subtest: relocations
[418.271514] Subtest relocations: SUCCESS (0.001s)
[418.413867] [128/131] (622s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[418.781459] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[418.782531] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[419.230155] [129/131] (621s left) kms_vblank (query-forked-hang)
[419.594631] Starting subtest: query-forked-hang
[419.595242] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.181843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.585s)
[426.203841] Starting dynamic subtest: pipe-B-HDMI-A-1
[432.182468] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.999s)
[432.183906] Subtest query-forked-hang: SUCCESS (12.589s)
[432.727685] [130/131] (608s left) gem_ringfill (basic-all)
[432.949631] Starting subtest: basic-all
[434.051558] Subtest basic-all: SUCCESS (1.101s)
[434.145339] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[434.148533] [131/131] (606s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[434.510997] Starting subtest: short-flip-before-cursor-toggle
[435.471810] Subtest short-flip-before-cursor-toggle: SUCCESS (0.961s)
[436.032452] 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.