[71.528672] Initializing watchdogs
[71.528891]   /dev/watchdog0
[71.549196] [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)
[71.557096] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.561196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.564236] [001/131] (960s left) gen9_exec_parse (allowed-single)
[71.651753] Subtest allowed-single: SKIP (0.000s)
[71.706402] [002/131] (960s left) gem_ctx_engines (invalid-engines)
[71.774235] Starting subtest: invalid-engines
[71.779656] Subtest invalid-engines: SUCCESS (0.005s)
[71.994856] [003/131] (960s left) syncobj_timeline (invalid-signal-illegal-point)
[72.050640] Starting subtest: invalid-signal-illegal-point
[72.051314] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[72.130784] [004/131] (960s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[72.499272] Starting subtest: plane-upscale-20x20-with-modifiers
[72.500146] Starting dynamic subtest: pipe-A
[72.502084] Dynamic subtest pipe-A: SKIP (0.001s)
[72.512072] Starting dynamic subtest: pipe-B
[72.514168] Dynamic subtest pipe-B: SKIP (0.001s)
[72.515851] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.003s)
[72.945124] [005/131] (959s left) gen9_exec_parse (bb-start-out)
[73.003304] Subtest bb-start-out: SKIP (0.000s)
[73.053410] [006/131] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[73.427075] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[73.428750] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[73.859336] [007/131] (958s left) kms_cursor_crc (cursor-sliding-32x10)
[74.241641] Starting subtest: cursor-sliding-32x10
[74.301241] Subtest cursor-sliding-32x10: SKIP (0.058s)
[74.739836] [008/131] (957s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[75.109273] Starting subtest: 2x-flip-vs-rmfb-interruptible
[75.110852] Starting dynamic subtest: AB-VGA1-HDMI-A1
[105.506666] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.394s)
[105.507452] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.396s)
[106.135884] [009/131] (926s left) gem_exercise_blt (fast-copy-emit)
[106.204071] Subtest fast-copy-emit: SKIP (0.000s)
[106.265874] [010/131] (926s left) core_getversion (all-cards)
[106.317807] Starting subtest: all-cards
[106.332163] Subtest all-cards: SUCCESS (0.015s)
[106.385567] [011/131] (926s left) i915_query (query-topology-kernel-writes)
[106.439086] Starting subtest: query-topology-kernel-writes
[106.440489] Subtest query-topology-kernel-writes: SKIP (0.000s)
[106.517626] [012/131] (926s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[106.884220] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[106.885097] Starting dynamic subtest: pipe-A
[106.887167] Dynamic subtest pipe-A: SKIP (0.002s)
[106.897970] Starting dynamic subtest: pipe-B
[106.900550] Dynamic subtest pipe-B: SKIP (0.002s)
[106.901991] Subtest plane-downscale-factor-0-75-with-pixel-format: SKIP (0.004s)
[107.352917] [013/131] (925s left) prime_busy (hang)
[107.414173] Starting subtest: hang
[107.414924] Starting dynamic subtest: rcs0
[113.850050] Dynamic subtest rcs0: SUCCESS (6.433s)
[113.861179] Starting dynamic subtest: bcs0
[119.855851] Dynamic subtest bcs0: SUCCESS (6.007s)
[119.864577] Starting dynamic subtest: vcs0
[125.874843] Dynamic subtest vcs0: SUCCESS (6.019s)
[125.876352] Subtest hang: SUCCESS (18.461s)
[125.980807] [014/131] (906s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[126.042998] Starting subtest: y-tiled-ccs-to-y-tiled
[126.046202] Starting dynamic subtest: smem
[126.047619] Dynamic subtest smem: SKIP (0.000s)
[126.049037] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[126.227891] [015/131] (906s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[126.604096] Starting subtest: x-tiled-8bpp-rotate-180
[127.922518] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.317s)
[128.397645] [016/131] (904s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[128.768859] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[128.770129] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[129.215270] [017/131] (903s left) kms_psr (psr-sprite-plane-onoff)
[129.581980] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[129.820487] [018/131] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[130.191765] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[130.193162] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[130.623338] [019/131] (902s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[130.998916] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[131.000450] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[131.425302] [020/131] (901s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[131.799239] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[131.800488] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[132.240853] [021/131] (900s left) kms_cursor_crc (cursor-suspend)
[132.605822] Starting subtest: cursor-suspend
[132.606553] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.057414] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.823s)
[167.073178] Starting dynamic subtest: pipe-B-HDMI-A-1
[202.091002] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.937s)
[202.091831] Subtest cursor-suspend: SUCCESS (3.763s)
[209.661231] [022/131] (830s left) syncobj_timeline (multi-wait-for-submit-signaled)
[209.750254] Starting subtest: multi-wait-for-submit-signaled
[209.751986] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[209.843333] [023/131] (830s left) perf_pmu (idle-no-semaphores)
[209.902415] Starting subtest: idle-no-semaphores
[209.903502] Starting dynamic subtest: rcs0
[210.443002] Dynamic subtest rcs0: SUCCESS (0.517s)
[210.467869] Starting dynamic subtest: bcs0
[210.980138] Dynamic subtest bcs0: SUCCESS (0.516s)
[211.006721] Starting dynamic subtest: vcs0
[211.516856] Dynamic subtest vcs0: SUCCESS (0.516s)
[211.518167] Subtest idle-no-semaphores: SUCCESS (1.552s)
[211.622637] [024/131] (828s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[212.000471] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[212.002015] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[212.470123] [025/131] (827s left) gem_eio (context-create)
[212.537896] Starting subtest: context-create
[212.560262] Subtest context-create: SUCCESS (0.023s)
[213.348229] [026/131] (826s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[213.722847] Starting subtest: basic-modeset-with-all-modifiers-formats
[213.872162] Starting dynamic subtest: pipe-A-HDMI-A-1-x-RGB565
[214.008436] Dynamic subtest pipe-A-HDMI-A-1-x-RGB565: SUCCESS (0.127s)
[214.034609] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB8888
[214.035984] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB8888: SUCCESS (0.011s)
[214.056250] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XRGB2101010
[214.057632] Dynamic subtest pipe-A-HDMI-A-1-x-XRGB2101010: SUCCESS (0.015s)
[214.077245] Starting dynamic subtest: pipe-A-HDMI-A-1-x-XBGR16161616F
[214.078674] Dynamic subtest pipe-A-HDMI-A-1-x-XBGR16161616F: SUCCESS (0.015s)
[214.205544] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (0.472s)
[214.799704] [027/131] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[215.182502] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[217.147696] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.927s)
[217.636666] [028/131] (822s left) kms_psr2_su (frontbuffer-xrgb8888)
[217.696817] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[217.751879] [029/131] (822s left) gem_exec_schedule (out-order)
[217.821103] Subtest out-order: SKIP (0.000s)
[218.024475] [030/131] (822s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[218.398645] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[220.990642] Subtest fbc-rgb101010-draw-mmap-gtt: SUCCESS (2.560s)
[221.485706] [031/131] (819s left) i915_query (query-topology-coherent-slice-mask)
[221.542795] Starting subtest: query-topology-coherent-slice-mask
[221.544538] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[221.645267] [032/131] (818s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[222.014433] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s)
[222.256467] [033/131] (818s left) gem_basic (multigpu-create-close)
[222.315645] Starting subtest: multigpu-create-close
[222.317542] Subtest multigpu-create-close: SKIP (0.000s)
[222.404318] [034/131] (818s left) gem_exec_balancer (parallel-contexts)
[222.462732] Subtest parallel-contexts: SKIP (0.000s)
[222.551294] [035/131] (818s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[222.923726] Starting subtest: fbcpsr-tiling-linear
[222.925467] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[223.374116] [036/131] (817s left) kms_lease (lease-invalid-plane)
[223.745789] Starting subtest: lease-invalid-plane
[223.748211] Starting dynamic subtest: pipe-A-HDMI-A-1
[223.748833] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[223.762468] Starting dynamic subtest: pipe-B-HDMI-A-1
[223.763110] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[223.763726] Subtest lease-invalid-plane: SUCCESS (0.005s)
[224.208134] [037/131] (816s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[224.575308] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[224.577186] Starting dynamic subtest: AB-VGA1-HDMI-A1
[289.070432] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (64.425s)
[289.073185] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (64.430s)
[289.720860] [038/131] (751s left) kms_pm_dc (dc5-dpms-negative)
[300.825827] Subtest dc5-dpms-negative: SKIP (0.000s)
[300.887342] [039/131] (740s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[301.256238] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[301.257875] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[301.701367] [040/131] (739s left) gem_mmap_gtt (big-bo)
[301.761337] Starting subtest: big-bo
[302.302915] Subtest big-bo: SUCCESS (0.542s)
[302.458862] [041/131] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[302.944305] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[302.945634] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[303.389857] [042/131] (737s left) tools_test (tools_test)
[303.458490] Starting subtest: tools_test
[303.575545] Subtest tools_test: SUCCESS (0.125s)
[303.658012] [043/131] (737s left) kms_atomic_transition (modeset-transition)
[304.028007] Starting subtest: modeset-transition
[304.028670] Starting dynamic subtest: 1x-outputs
[305.008153] Dynamic subtest 1x-outputs: SUCCESS (0.980s)
[305.045701] Subtest modeset-transition: SUCCESS (1.017s)
[305.595604] [044/131] (735s left) gem_mmap_offset (partial-mmap)
[305.651419] Starting subtest: partial-mmap
[305.652236] Starting dynamic subtest: smem0
[305.656000] Dynamic subtest smem0: SUCCESS (0.005s)
[305.656785] Subtest partial-mmap: SUCCESS (0.006s)
[305.768815] [045/131] (735s left) kms_color (legacy-gamma-reset)
[306.133719] Starting subtest: legacy-gamma-reset
[306.134676] Starting dynamic subtest: pipe-A-HDMI-A-1
[306.286222] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.152s)
[306.302601] Starting dynamic subtest: pipe-B-HDMI-A-1
[306.303296] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.007s)
[306.303991] Subtest legacy-gamma-reset: SUCCESS (0.162s)
[306.870527] [046/131] (734s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[306.935305] Starting subtest: mixed-tiled-to-y-tiled-ccs
[306.936088] Starting dynamic subtest: smem
[306.937748] Dynamic subtest smem: SKIP (0.000s)
[306.939224] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.001s)
[307.148749] [047/131] (734s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[307.514937] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[307.772453] [048/131] (733s left) kms_vrr (flipline)
[308.137182] Starting subtest: flipline
[308.139448] Subtest flipline: SKIP (0.000s)
[308.573395] [049/131] (732s left) gem_pxp (regular-baseline-src-copy-readible)
[311.143335] Starting subtest: regular-baseline-src-copy-readible
[311.144830] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[311.233732] [050/131] (730s left) kms_psr (psr-primary-blt)
[311.593118] Subtest psr-primary-blt: SKIP (0.000s)
[311.827974] [051/131] (729s left) kms_chamelium_frames (dp-crc-fast)
[312.265669] Subtest dp-crc-fast: SKIP (0.000s)
[312.625173] [052/131] (729s left) gem_ctx_persistence (legacy-engines-mixed)
[312.687783] Subtest legacy-engines-mixed: SKIP (0.000s)
[312.764542] [053/131] (728s left) kms_pm_rpm (pm-caching)
[324.362603] Subtest pm-caching: SKIP (0.000s)
[324.597019] [054/131] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[324.962299] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[324.965734] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[325.397196] [055/131] (716s left) syncobj_basic (illegal-fd-to-handle)
[325.453979] Starting subtest: illegal-fd-to-handle
[325.455942] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[325.551438] [056/131] (716s left) api_intel_allocator (fork-simple-once)
[325.608076] Starting subtest: fork-simple-once
[325.633463] Subtest fork-simple-once: SUCCESS (0.025s)
[325.779365] [057/131] (716s left) gem_userptr_blits (unsync-unmap-after-close)
[325.837821] Subtest unsync-unmap-after-close: SKIP (0.000s)
[325.963431] [058/131] (715s left) syncobj_wait (multi-wait-all-signaled)
[326.037357] Starting subtest: multi-wait-all-signaled
[326.038158] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[326.131313] [059/131] (715s left) kms_dsc (dsc-with-output-formats-with-bpc)
[326.499813] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[326.751931] [060/131] (715s left) gem_create (create-ext-cpu-access-big)
[326.925006] Starting subtest: create-ext-cpu-access-big
[326.926355] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[327.014193] [061/131] (715s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[327.069003] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[327.127261] [062/131] (715s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[327.493255] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[327.494772] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[327.929450] [063/131] (714s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[328.299794] Starting subtest: psr-shrfb-scaledprimary
[328.300915] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[328.744418] [064/131] (713s left) i915_pm_freq_api (freq-basic-api)
[328.807477] Subtest freq-basic-api: SKIP (0.000s)
[328.866799] [065/131] (713s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[329.233963] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[329.235315] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[329.672948] [066/131] (712s left) perf (blocking)
[329.826185] Subtest blocking: SKIP (0.000s)
[329.883061] [067/131] (712s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[329.937812] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[329.999994] [068/131] (712s left) sysfs_defaults (readonly)
[330.057171] Starting subtest: readonly
[330.059888] Starting dynamic subtest: vcs0
[330.061216] Dynamic subtest vcs0: SUCCESS (0.001s)
[330.080577] Starting dynamic subtest: bcs0
[330.081847] Dynamic subtest bcs0: SUCCESS (0.000s)
[330.102216] Starting dynamic subtest: rcs0
[330.106154] Dynamic subtest rcs0: SUCCESS (0.001s)
[330.107004] Subtest readonly: SUCCESS (0.009s)
[330.152664] [069/131] (712s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[330.522149] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[330.524130] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[330.984984] [070/131] (711s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[331.044934] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[331.154794] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s)
[331.246718] [071/131] (711s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[331.615563] Starting subtest: x-tiled-32bpp-rotate-180
[333.048939] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.434s)
[333.529185] [072/131] (709s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[333.901698] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[333.903203] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[334.331553] [073/131] (708s left) kms_3d
[338.173465] [074/131] (704s left) gem_reg_read (bad-register)
[338.233294] Starting subtest: bad-register
[338.233988] Subtest bad-register: SUCCESS (0.000s)
[338.332995] [075/131] (704s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[338.702829] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[338.704187] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[339.134853] [076/131] (703s left) gem_readwrite (new-obj)
[339.199861] Starting subtest: new-obj
[339.201354] Subtest new-obj: SUCCESS (0.001s)
[339.320621] [077/131] (703s left) kms_psr (pr-suspend)
[339.678889] Subtest pr-suspend: SKIP (0.000s)
[339.905514] [078/131] (703s left) gem_caching (writes)
[339.969731] Starting subtest: writes
[342.963249] Subtest writes: SUCCESS (2.994s)
[343.089989] [079/131] (699s left) kms_force_connector_basic (force-load-detect)
[343.162923] Starting subtest: force-load-detect
[343.378778] Subtest force-load-detect: SUCCESS (0.217s)
[343.818381] [080/131] (699s left) syncobj_timeline (32bits-limit)
[343.880324] Starting subtest: 32bits-limit
[343.882448] Subtest 32bits-limit: SUCCESS (0.001s)
[343.970640] [081/131] (699s left) gem_userptr_blits (coherency-unsync)
[344.025496] Subtest coherency-unsync: SKIP (0.000s)
[344.151045] [082/131] (699s left) gem_mmap_offset (bad-flags)
[344.204573] Starting subtest: bad-flags
[344.205322] Subtest bad-flags: SUCCESS (0.000s)
[344.317378] [083/131] (698s left) kms_fbcon_fbt (fbc)
[344.376864] Starting subtest: fbc
[347.804941] Subtest fbc: SUCCESS (3.426s)
[347.861781] [084/131] (695s left) kms_cursor_crc (cursor-random-256x256)
[348.236579] Starting subtest: cursor-random-256x256
[348.239187] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.906684] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.664s)
[351.953460] Starting dynamic subtest: pipe-B-HDMI-A-1
[355.644460] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.707s)
[355.645128] Subtest cursor-random-256x256: SUCCESS (7.406s)
[356.217528] [085/131] (687s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[356.279188] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[356.337900] [086/131] (687s left) gem_exec_params (invalid-bsd-ring)
[356.393115] Starting subtest: invalid-bsd-ring
[356.393898] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[356.494009] [087/131] (686s left) gem_exec_endless (dispatch)
[356.550181] Subtest dispatch: SKIP (0.000s)
[356.643535] [088/131] (686s left) kms_psr (fbc-psr-no-drrs)
[357.008790] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[357.237113] [089/131] (686s left) gem_userptr_blits (sync-overlap)
[357.312166] Starting subtest: sync-overlap
[357.313503] Subtest sync-overlap: SUCCESS (0.000s)
[357.450250] [090/131] (686s left) kms_plane_lowres (tiling-y)
[357.813388] Starting subtest: tiling-y
[357.815141] Subtest tiling-y: SKIP (0.000s)
[358.242835] [091/131] (685s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[358.628920] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[358.630324] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[359.072459] [092/131] (684s left) kms_busy (extended-pageflip-hang-oldfb)
[359.444882] Starting subtest: extended-pageflip-hang-oldfb
[359.446801] Starting dynamic subtest: pipe-A
[359.620624] Dynamic subtest pipe-A: SUCCESS (0.174s)
[359.635916] Starting dynamic subtest: pipe-B
[359.876861] Dynamic subtest pipe-B: SUCCESS (0.252s)
[359.877671] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.433s)
[360.439088] [093/131] (683s left) gem_lmem_swapping (random-engines)
[360.502893] Subtest random-engines: SKIP (0.000s)
[360.563724] [094/131] (683s left) perf (gen8-unprivileged-single-ctx-counters)
[360.668895] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[360.737289] [095/131] (683s left) kms_chamelium_hpd (dp-hpd-storm)
[361.188376] Subtest dp-hpd-storm: SKIP (0.000s)
[361.528486] [096/131] (682s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[361.588976] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[361.589692] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[361.682084] [097/131] (682s left) gem_exec_schedule (u-semaphore-codependency)
[361.753744] Subtest u-semaphore-codependency: SKIP (0.000s)
[361.946963] [098/131] (682s left) kms_draw_crc (draw-method-mmap-cpu)
[362.311865] Starting subtest: draw-method-mmap-cpu
[362.312774] Starting dynamic subtest: xrgb8888-untiled
[362.597458] Dynamic subtest xrgb8888-untiled: SUCCESS (0.285s)
[362.616325] Starting dynamic subtest: rgb565-untiled
[362.880641] Dynamic subtest rgb565-untiled: SUCCESS (0.280s)
[362.899415] Starting dynamic subtest: xrgb2101010-untiled
[363.182957] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.297s)
[363.197617] Starting dynamic subtest: xbgr16161616f-untiled
[363.529290] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.346s)
[363.547843] Starting dynamic subtest: xrgb8888-xtiled
[363.712351] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.180s)
[363.728255] Starting dynamic subtest: rgb565-xtiled
[363.878435] Dynamic subtest rgb565-xtiled: SUCCESS (0.163s)
[363.894632] Starting dynamic subtest: xrgb2101010-xtiled
[364.061375] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.180s)
[364.077799] Starting dynamic subtest: xbgr16161616f-xtiled
[364.277747] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.214s)
[364.278793] Subtest draw-method-mmap-cpu: SUCCESS (1.967s)
[364.739980] [099/131] (679s left) kms_prop_blob (invalid-get-prop-any)
[364.794450] Starting subtest: invalid-get-prop-any
[364.795192] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[364.899100] [100/131] (679s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[365.261861] Starting subtest: addfb25-y-tiled-legacy
[365.262730] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[365.707262] [101/131] (678s left) gem_spin_batch (spin-all)
[365.773210] Starting subtest: spin-all
[365.775778] Subtest spin-all: SUCCESS (0.003s)
[365.974636] [102/131] (678s left) kms_invalid_mode (bad-vtotal)
[366.339491] Starting subtest: bad-vtotal
[366.340346] Starting dynamic subtest: pipe-A-HDMI-A-1
[366.409126] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.068s)
[366.425797] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.426567] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[366.427328] Subtest bad-vtotal: SUCCESS (0.073s)
[366.802979] [103/131] (677s left) core_auth (many-magics)
[366.858461] Starting subtest: many-magics
[367.302755] Subtest many-magics: SUCCESS (0.444s)
[367.401326] [104/131] (676s left) i915_drm_fdinfo (memory-info-shared)
[367.459323] Subtest memory-info-shared: SKIP (0.000s)
[367.513656] [105/131] (676s left) gem_exec_schedule (preempt)
[367.581792] Subtest preempt: SKIP (0.000s)
[367.787505] [106/131] (676s left) gem_exec_create (forked)
[367.848293] Starting subtest: forked
[367.849191] Starting dynamic subtest: smem
[387.957915] Dynamic subtest smem: SUCCESS (20.103s)
[387.961193] Subtest forked: SUCCESS (20.106s)
[388.163379] [107/131] (656s left) syncobj_wait (wait-for-submit-complex)
[388.219835] Starting subtest: wait-for-submit-complex
[388.283317] Subtest wait-for-submit-complex: SUCCESS (0.063s)
[388.381455] [108/131] (656s left) gem_userptr_blits (map-fixed-invalidate-busy)
[388.460189] Starting subtest: map-fixed-invalidate-busy
[388.460817] Starting dynamic subtest: gtt
[389.472979] Dynamic subtest gtt: SUCCESS (1.013s)
[389.487070] Starting dynamic subtest: wb
[390.459682] Dynamic subtest wb: SUCCESS (0.987s)
[390.473680] Starting dynamic subtest: wc
[391.441340] Dynamic subtest wc: SUCCESS (0.980s)
[391.457353] Starting dynamic subtest: uc
[392.419234] Dynamic subtest uc: SUCCESS (0.976s)
[392.420007] Subtest map-fixed-invalidate-busy: SUCCESS (3.962s)
[392.560380] [109/131] (651s left) kms_plane_alpha_blend (constant-alpha-max)
[392.928510] Starting subtest: constant-alpha-max
[393.092033] Subtest constant-alpha-max: SKIP (0.162s)
[393.731680] [110/131] (650s left) i915_pm_rpm (sysfs-read)
[405.337427] Subtest sysfs-read: SKIP (0.000s)
[405.575080] [111/131] (639s left) api_intel_bb (intel-bb-blit-x)
[405.633390] Starting subtest: intel-bb-blit-x
[408.559847] Subtest intel-bb-blit-x: SUCCESS (2.925s)
[408.687641] [112/131] (636s left) gem_exec_parallel (userptr)
[408.755102] Starting subtest: userptr
[408.755984] Starting dynamic subtest: rcs0
[410.295094] Dynamic subtest rcs0: SUCCESS (1.538s)
[410.312669] Starting dynamic subtest: bcs0
[411.805421] Dynamic subtest bcs0: SUCCESS (1.507s)
[411.806644] Subtest userptr: SUCCESS (3.050s)
[412.018249] [113/131] (632s left) gem_ctx_shared (q-promotion)
[412.073944] Subtest Q-promotion: SKIP (0.000s)
[412.163532] [114/131] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[412.533815] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[412.535202] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[412.977545] [115/131] (631s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[413.032475] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[413.091555] [116/131] (631s left) kms_cursor_crc (cursor-offscreen-256x85)
[413.458364] Starting subtest: cursor-offscreen-256x85
[413.513872] Subtest cursor-offscreen-256x85: SKIP (0.054s)
[413.946927] [117/131] (631s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[414.009612] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[414.071153] [118/131] (630s left) kms_flip (2x-absolute-wf_vblank)
[414.431448] Starting subtest: 2x-absolute-wf_vblank
[414.433604] Starting dynamic subtest: AB-VGA1-HDMI-A1
[444.869581] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.436s)
[444.872370] Subtest 2x-absolute-wf_vblank: SUCCESS (30.441s)
[445.558243] [119/131] (599s left) perf (buffer-fill)
[445.662566] Subtest buffer-fill: SKIP (0.000s)
[445.732622] [120/131] (599s left) kms_addfb_basic (bad-pitch-128)
[445.789296] Starting subtest: bad-pitch-128
[445.790164] Subtest bad-pitch-128: SUCCESS (0.000s)
[446.547170] [121/131] (598s left) gem_exec_flush (basic-batch-kernel-default-uc)
[446.613916] Starting subtest: basic-batch-kernel-default-uc
[452.186627] Subtest basic-batch-kernel-default-uc: SUCCESS (5.574s)
[452.397510] [122/131] (592s left) syncobj_timeline (wait-all-interrupted)
[452.460424] Starting subtest: wait-all-interrupted
[452.562000] Subtest wait-all-interrupted: SUCCESS (0.101s)
[452.662271] [123/131] (592s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[453.028595] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[453.030222] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[453.476368] [124/131] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[453.842450] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[453.843638] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[454.291405] [125/131] (591s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[454.348907] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[454.401055] [126/131] (591s left) perf (gen12-unprivileged-single-ctx-counters)
[454.506535] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[454.565407] [127/131] (590s left) gem_userptr_blits (relocations)
[454.626578] Starting subtest: relocations
[454.629262] Subtest relocations: SUCCESS (0.001s)
[454.775185] [128/131] (590s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[455.139599] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[455.141057] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[455.584079] [129/131] (590s left) kms_vblank (query-forked-hang)
[455.956652] Starting subtest: query-forked-hang
[455.957679] Starting dynamic subtest: pipe-A-HDMI-A-1
[462.637351] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.680s)
[462.651386] Starting dynamic subtest: pipe-B-HDMI-A-1
[468.655031] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.016s)
[468.655709] Subtest query-forked-hang: SUCCESS (12.703s)
[469.207138] [130/131] (576s left) gem_ringfill (basic-all)
[469.426758] Starting subtest: basic-all
[470.527582] Subtest basic-all: SUCCESS (1.100s)
[470.639859] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[470.643704] [131/131] (575s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[471.014169] Starting subtest: short-flip-before-cursor-toggle
[471.979068] Subtest short-flip-before-cursor-toggle: SUCCESS (0.964s)
[472.536420] 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.