[71.085307] Initializing watchdogs
[71.085449]   /dev/watchdog0
[71.108145] [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.115588] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.120327] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.124154] [001/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[71.455718] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[71.457332] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[71.864134] [002/131] (959s left) gem_userptr_blits (dmabuf-sync)
[71.943656] Starting subtest: dmabuf-sync
[71.948615] Subtest dmabuf-sync: SKIP (0.005s)
[72.105463] [003/131] (959s left) gem_exec_reloc (basic-scanout)
[72.407748] Starting subtest: basic-scanout
[72.408573] Starting dynamic subtest: rcs0
[72.754588] Dynamic subtest rcs0: SUCCESS (0.349s)
[72.763948] Starting dynamic subtest: bcs0
[72.886923] Dynamic subtest bcs0: SUCCESS (0.132s)
[72.896630] Starting dynamic subtest: vcs0
[73.020331] Dynamic subtest vcs0: SUCCESS (0.132s)
[73.021669] Subtest basic-scanout: SUCCESS (0.615s)
[73.448576] [004/131] (958s left) syncobj_timeline (wait-for-submit-delayed-submit)
[73.503327] Starting subtest: wait-for-submit-delayed-submit
[73.607168] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[73.728609] [005/131] (958s left) kms_color (ctm-0-50)
[74.023181] Starting subtest: ctm-0-50
[74.024086] Starting dynamic subtest: pipe-A-HDMI-A-1
[75.464805] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.439s)
[75.475559] Starting dynamic subtest: pipe-B-HDMI-A-1
[76.950619] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.489s)
[76.951588] Subtest ctm-0-50: SUCCESS (2.929s)
[77.465297] [006/131] (954s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[77.776481] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[77.777223] Starting dynamic subtest: pipe-A
[77.780166] Dynamic subtest pipe-A: SKIP (0.001s)
[77.791406] Starting dynamic subtest: pipe-B
[77.793559] Dynamic subtest pipe-B: SKIP (0.002s)
[77.794923] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.004s)
[78.183324] [007/131] (953s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[78.495843] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[78.497294] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[78.898952] [008/131] (953s left) gem_exec_flush (basic-wb-pro-default)
[78.963074] Starting subtest: basic-wb-pro-default
[84.409552] Subtest basic-wb-pro-default: SUCCESS (5.444s)
[84.641775] [009/131] (947s left) kms_invalid_mode (bad-htotal)
[84.941912] Starting subtest: bad-htotal
[84.942785] Starting dynamic subtest: pipe-A-HDMI-A-1
[85.011860] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.069s)
[85.023507] Starting dynamic subtest: pipe-B-HDMI-A-1
[85.026064] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[85.026824] Subtest bad-htotal: SUCCESS (0.072s)
[85.401891] [010/131] (946s left) gem_lmem_swapping (verify-ccs)
[85.468491] Subtest verify-ccs: SKIP (0.000s)
[85.514812] [011/131] (946s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[85.818218] Starting subtest: basic-flip-before-cursor-varying-size
[86.791488] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.974s)
[87.306657] [012/131] (944s left) kms_chamelium_color (ctm-max)
[87.611011] Subtest ctm-max: SKIP (0.000s)
[87.797885] [013/131] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[88.102409] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[88.103929] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[88.492922] [014/131] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[88.788958] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[88.790236] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[89.171673] [015/131] (943s left) gem_userptr_blits (set-cache-level)
[89.234750] Starting subtest: set-cache-level
[89.235610] Subtest set-cache-level: SUCCESS (0.000s)
[89.386208] [016/131] (942s left) gem_ctx_shared (disjoint-timelines)
[89.442335] Subtest disjoint-timelines: SKIP (0.000s)
[89.574026] [017/131] (942s left) gem_busy (busy)
[89.641914] Starting subtest: busy
[89.642849] Starting dynamic subtest: all-engines
[89.667566] Dynamic subtest all-engines: SUCCESS (0.025s)
[89.686125] Starting dynamic subtest: rcs0
[89.692682] Dynamic subtest rcs0: SUCCESS (0.025s)
[89.706792] Starting dynamic subtest: bcs0
[89.710355] Dynamic subtest bcs0: SUCCESS (0.014s)
[89.725030] Starting dynamic subtest: vcs0
[89.725913] Dynamic subtest vcs0: SUCCESS (0.014s)
[89.727029] Subtest busy: SUCCESS (0.080s)
[90.101130] [018/131] (942s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[92.669629] Starting subtest: verify-pxp-key-change-after-suspend-resume
[92.671666] Subtest verify-pxp-key-change-after-suspend-resume: SKIP (0.000s)
[92.795659] [019/131] (939s left) gem_eio (hibernate)
[92.859072] Starting subtest: hibernate
[106.726940] Subtest hibernate: SUCCESS (13.866s)
[113.367119] [020/131] (925s left) kms_busy (basic)
[113.700681] Starting subtest: basic
[113.701592] Starting dynamic subtest: flip
[114.108129] Dynamic subtest flip: SUCCESS (0.408s)
[114.119208] Starting dynamic subtest: modeset
[114.901512] Dynamic subtest modeset: SUCCESS (0.793s)
[114.902266] Subtest basic: SUCCESS (1.202s)
[115.446916] [021/131] (923s left) gem_exec_whisper (basic-contexts-forked-all)
[115.515827] Starting subtest: basic-contexts-forked-all
[118.702954] Subtest basic-contexts-forked-all: SUCCESS (3.187s)
[118.938945] [022/131] (919s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[118.997726] Starting subtest: basic-cpu-wc-noreloc
[118.999091] Subtest basic-cpu-wc-noreloc: SUCCESS (0.002s)
[119.637546] [023/131] (918s left) core_getclient (basic)
[119.694705] Starting subtest: basic
[119.695472] Subtest basic: SUCCESS (0.000s)
[119.821278] [024/131] (918s left) gem_mmap_wc (invalid-flags)
[119.874906] Starting subtest: invalid-flags
[119.875680] Subtest invalid-flags: SUCCESS (0.000s)
[120.021069] [025/131] (918s left) gem_ctx_persistence (heartbeat-stop)
[120.079673] Subtest heartbeat-stop: SKIP (0.000s)
[120.134535] [026/131] (918s left) kms_hdr (bpc-switch-dpms)
[120.428137] Starting subtest: bpc-switch-dpms
[126.284844] Subtest bpc-switch-dpms: SKIP (5.857s)
[126.915519] [027/131] (911s left) gem_eio (in-flight-internal-10ms)
[126.997120] Starting subtest: in-flight-internal-10ms
[127.050849] Subtest in-flight-internal-10ms: SUCCESS (0.054s)
[127.703584] [028/131] (911s left) perf (unprivileged-single-ctx-counters)
[127.842430] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[127.891934] [029/131] (911s left) kms_addfb_basic (no-handle)
[127.949347] Starting subtest: no-handle
[127.950173] Subtest no-handle: SUCCESS (0.000s)
[128.598084] [030/131] (910s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[128.891936] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[143.739154] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (14.848s)
[144.233335] [031/131] (894s left) gem_ctx_persistence (engines-hostile-preempt)
[144.295251] Subtest engines-hostile-preempt: SKIP (0.000s)
[144.373370] [032/131] (894s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[144.681492] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[144.683041] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[145.091915] [033/131] (894s left) gen7_exec_parse (cmd-crossing-page)
[145.152753] Subtest cmd-crossing-page: SKIP (0.000s)
[145.207624] [034/131] (893s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[145.263611] Starting subtest: multi-wait-available-unsubmitted-signaled
[145.265325] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[145.367666] [035/131] (893s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[145.664252] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[145.860263] [036/131] (893s left) gem_ppgtt (shrink-vs-evict-any)
[145.922104] Starting subtest: shrink-vs-evict-any
[145.923510] Subtest shrink-vs-evict-any: SKIP (0.002s)
[145.992446] [037/131] (893s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[146.289017] Starting subtest: flip-vs-cursor-crc-legacy
[146.822372] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.534s)
[147.318437] [038/131] (892s left) gem_exec_capture (capture)
[147.378785] Subtest capture: SKIP (0.000s)
[147.457431] [039/131] (891s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[147.756649] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[147.758095] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[148.154551] [040/131] (891s left) kms_psr (fbc-psr-sprite-plane-move)
[148.452697] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s)
[148.665044] [041/131] (890s left) kms_plane_scaling (planes-downscale-factor-0-75)
[148.963241] Starting subtest: planes-downscale-factor-0-75
[148.963952] Starting dynamic subtest: pipe-A
[148.966427] Dynamic subtest pipe-A: SKIP (0.001s)
[148.982111] Starting dynamic subtest: pipe-B
[148.984343] Dynamic subtest pipe-B: SKIP (0.001s)
[148.985710] Subtest planes-downscale-factor-0-75: SKIP (0.005s)
[149.373288] [042/131] (890s left) kms_flip (flip-vs-rmfb)
[149.672793] Starting subtest: flip-vs-rmfb
[149.673664] Starting dynamic subtest: A-VGA1
[157.445295] Dynamic subtest A-VGA1: SUCCESS (7.772s)
[157.459857] Starting dynamic subtest: B-VGA1
[165.168747] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[165.182992] Starting dynamic subtest: A-HDMI-A1
[172.908692] Dynamic subtest A-HDMI-A1: SUCCESS (7.737s)
[172.923031] Starting dynamic subtest: B-HDMI-A1
[180.683736] Dynamic subtest B-HDMI-A1: SUCCESS (7.772s)
[180.687143] Subtest flip-vs-rmfb: SUCCESS (31.014s)
[181.274527] [043/131] (858s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[181.580537] Starting subtest: cursorA-vs-flipB-toggle
[181.582171] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[181.991747] [044/131] (857s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[182.295230] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[182.313238] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.017s)
[182.742682] [045/131] (856s left) kms_vblank (ts-continuation-dpms-rpm)
[183.045472] Starting subtest: ts-continuation-dpms-rpm
[183.046638] Starting dynamic subtest: pipe-A-HDMI-A-1
[194.220776] Dynamic subtest pipe-A-HDMI-A-1: SKIP (11.173s)
[194.236079] Starting dynamic subtest: pipe-B-HDMI-A-1
[205.553897] Dynamic subtest pipe-B-HDMI-A-1: SKIP (11.330s)
[205.555584] Subtest ts-continuation-dpms-rpm: SKIP (22.510s)
[206.137113] [046/131] (833s left) gem_exec_schedule (pi-distinct-iova)
[206.214243] Subtest pi-distinct-iova: SKIP (0.000s)
[206.453129] [047/131] (833s left) kms_async_flips (invalid-async-flip-atomic)
[206.746870] Starting subtest: invalid-async-flip-atomic
[206.898253] Starting dynamic subtest: pipe-A-HDMI-A-1
[207.048412] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.149s)
[207.211953] Starting dynamic subtest: pipe-B-HDMI-A-1
[207.306722] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.104s)
[207.308598] Subtest invalid-async-flip-atomic: SKIP (0.560s)
[207.952261] [048/131] (831s left) i915_pm_sseu (full-enable)
[208.015301] Subtest full-enable: SKIP (0.000s)
[208.136804] [049/131] (831s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled)
[208.193375] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[208.194034] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[208.326320] [050/131] (831s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[208.626918] Starting subtest: cursorB-vs-flipA-legacy
[208.628457] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s)
[209.040498] [051/131] (830s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[209.344552] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[209.346255] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[209.758652] [052/131] (830s left) gem_exec_schedule (semaphore-codependency)
[209.838979] Subtest semaphore-codependency: SKIP (0.000s)
[210.053960] [053/131] (830s left) kms_psr (psr-primary-mmap-gtt)
[210.346937] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[210.550713] [054/131] (829s left) kms_draw_crc (draw-method-render)
[210.847502] Starting subtest: draw-method-render
[210.848277] Starting dynamic subtest: xrgb8888-untiled
[211.139198] Dynamic subtest xrgb8888-untiled: SUCCESS (0.292s)
[211.158535] Starting dynamic subtest: rgb565-untiled
[211.423060] Dynamic subtest rgb565-untiled: SUCCESS (0.282s)
[211.437936] Starting dynamic subtest: xrgb2101010-untiled
[211.739662] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s)
[211.754770] Starting dynamic subtest: xbgr16161616f-untiled
[212.089689] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.347s)
[212.104908] Starting dynamic subtest: xrgb8888-xtiled
[212.256606] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[212.271970] Starting dynamic subtest: rgb565-xtiled
[212.406491] Dynamic subtest rgb565-xtiled: SUCCESS (0.147s)
[212.421387] Starting dynamic subtest: xrgb2101010-xtiled
[212.573156] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[212.587916] Starting dynamic subtest: xbgr16161616f-xtiled
[212.758066] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s)
[212.760266] Subtest draw-method-render: SUCCESS (1.911s)
[213.190310] [055/131] (827s left) kms_plane_lowres (tiling-none)
[213.484916] Starting subtest: tiling-none
[213.485850] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.056998] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.571s)
[216.158716] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.618731] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.470s)
[218.705116] Subtest tiling-none: SUCCESS (5.222s)
[219.239519] [056/131] (821s left) gem_exec_fence (syncobj-invalid-flags)
[219.486977] Starting subtest: syncobj-invalid-flags
[219.487880] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[219.842931] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[219.846446] [057/131] (820s left) gem_exec_reloc (basic-write-gtt-active)
[219.903293] Starting subtest: basic-write-gtt-active
[220.013802] Subtest basic-write-gtt-active: SUCCESS (0.111s)
[220.663715] [058/131] (819s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[220.971234] Starting subtest: 4-tiled-32bpp-rotate-180
[220.972548] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[221.381350] [059/131] (819s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[221.437008] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s)
[221.493382] [060/131] (818s left) kms_async_flips (crc)
[221.784821] Starting subtest: crc
[221.935770] Starting dynamic subtest: pipe-A-HDMI-A-1
[224.192531] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.256s)
[224.363683] Starting dynamic subtest: pipe-B-HDMI-A-1
[226.551276] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.199s)
[226.554997] Subtest crc: SUCCESS (4.769s)
[227.220910] [061/131] (813s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[227.531757] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[227.533491] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[227.951885] [062/131] (812s left) kms_flip (plain-flip-ts-check)
[228.245388] Starting subtest: plain-flip-ts-check
[228.246105] Starting dynamic subtest: A-VGA1
[236.289806] Dynamic subtest A-VGA1: SUCCESS (8.043s)
[236.304762] Starting dynamic subtest: B-VGA1
[244.280691] Dynamic subtest B-VGA1: SUCCESS (7.988s)
[244.296394] Starting dynamic subtest: A-HDMI-A1
[252.304747] Dynamic subtest A-HDMI-A1: SUCCESS (8.020s)
[252.322180] Starting dynamic subtest: B-HDMI-A1
[260.361564] Dynamic subtest B-HDMI-A1: SUCCESS (8.053s)
[260.366247] Subtest plain-flip-ts-check: SUCCESS (32.118s)
[260.958817] [063/131] (779s left) kms_frontbuffer_tracking (basic)
[261.267941] Starting subtest: basic
[263.687498] Subtest basic: SUCCESS (2.419s)
[264.126782] [064/131] (776s left) gem_exec_balancer (nohangcheck)
[264.186735] Subtest nohangcheck: SKIP (0.000s)
[264.305725] [065/131] (776s left) kms_cursor_crc (cursor-random-128x128)
[264.606227] Starting subtest: cursor-random-128x128
[264.608434] Starting dynamic subtest: pipe-A-HDMI-A-1
[268.309847] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.700s)
[268.352708] Starting dynamic subtest: pipe-B-HDMI-A-1
[272.041460] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.700s)
[272.042161] Subtest cursor-random-128x128: SUCCESS (7.436s)
[272.556643] [066/131] (768s left) dmabuf_sync_file (export-wait-after-attach)
[272.617946] Starting subtest: export-wait-after-attach
[272.618748] Subtest export-wait-after-attach: SUCCESS (0.001s)
[272.738736] [067/131] (768s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[273.035336] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[273.036788] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[273.434460] [068/131] (767s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[273.735474] Starting subtest: psr-modesetfrombusy
[273.736724] Subtest psr-modesetfrombusy: SKIP (0.000s)
[274.154901] [069/131] (766s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[274.222556] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[274.224556] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[274.472638] [070/131] (766s left) gem_close_race (multigpu-basic-process)
[274.538565] Starting subtest: multigpu-basic-process
[274.540087] Subtest multigpu-basic-process: SKIP (0.000s)
[274.802781] [071/131] (766s left) perf (gen12-unprivileged-single-ctx-counters)
[274.922098] Subtest gen12-unprivileged-single-ctx-counters: SKIP (0.000s)
[274.981336] [072/131] (766s left) kms_prime (basic-crc-vgem)
[275.288721] Starting subtest: basic-crc-vgem
[275.289352] Starting dynamic subtest: second-to-first
[276.544748] Dynamic subtest second-to-first: SUCCESS (1.255s)
[276.548106] Subtest basic-crc-vgem: SUCCESS (1.258s)
[277.589533] [073/131] (763s left) gem_eio (wait-wedge-1us)
[277.658404] Starting subtest: wait-wedge-1us
[277.694291] Subtest wait-wedge-1us: SUCCESS (0.036s)
[278.355858] [074/131] (762s left) prime_busy (hang)
[278.412495] Starting subtest: hang
[278.413210] Starting dynamic subtest: rcs0
[284.852047] Dynamic subtest rcs0: SUCCESS (6.437s)
[284.866026] Starting dynamic subtest: bcs0
[290.864778] Dynamic subtest bcs0: SUCCESS (6.010s)
[290.878021] Starting dynamic subtest: vcs0
[296.878256] Dynamic subtest vcs0: SUCCESS (6.012s)
[296.880331] Subtest hang: SUCCESS (18.467s)
[297.049102] [075/131] (744s left) sysfs_defaults (readonly)
[297.109206] Starting subtest: readonly
[297.111472] Starting dynamic subtest: vcs0
[297.112300] Dynamic subtest vcs0: SUCCESS (0.001s)
[297.128266] Starting dynamic subtest: bcs0
[297.129603] Dynamic subtest bcs0: SUCCESS (0.001s)
[297.148036] Starting dynamic subtest: rcs0
[297.149402] Dynamic subtest rcs0: SUCCESS (0.000s)
[297.150610] Subtest readonly: SUCCESS (0.007s)
[297.233517] [076/131] (744s left) syncobj_timeline (invalid-query-illegal-handle)
[297.290120] Starting subtest: invalid-query-illegal-handle
[297.290852] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[297.420460] [077/131] (744s left) kms_psr (fbc-psr2-primary-blt)
[297.715972] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[297.913769] [078/131] (743s left) gem_render_linear_blits (basic)
[297.970548] Starting subtest: basic
[297.991979] Subtest basic: SUCCESS (0.021s)
[298.084748] [079/131] (743s left) api_intel_allocator (open-vm)
[298.138445] Starting subtest: open-vm
[298.142765] Subtest open-vm: SUCCESS (0.005s)
[298.301897] [080/131] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[298.604400] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[298.605707] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[299.018408] [081/131] (742s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[299.077068] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[299.146916] [082/131] (742s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[299.442946] Starting subtest: flip-vs-cursor-crc-atomic
[299.970841] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.528s)
[300.484736] [083/131] (741s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[300.543507] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[300.623730] [084/131] (741s left) gem_exec_suspend (basic-s3)
[300.688496] Starting subtest: basic-S3
[300.689355] Starting dynamic subtest: smem
[318.076335] Dynamic subtest smem: SUCCESS (1.323s)
[318.077365] Subtest basic-S3: SUCCESS (1.325s)
[325.329391] [085/131] (723s left) i915_drm_fdinfo (isolation)
[325.391616] Subtest isolation: SKIP (0.000s)
[325.470693] [086/131] (723s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[325.766411] Starting subtest: basic-busy-flip-before-cursor-varying-size
[325.767712] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[326.161899] [087/131] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[326.470736] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[326.472006] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[326.886788] [088/131] (722s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[327.188504] Starting subtest: psr-shrfb-scaledprimary
[327.189874] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[327.628115] [089/131] (721s left) kms_chamelium_frames (dp-crc-single)
[328.024654] Subtest dp-crc-single: SKIP (0.000s)
[328.331849] [090/131] (720s left) gem_exec_whisper (basic-sync)
[328.401876] Starting subtest: basic-sync
[329.711372] Subtest basic-sync: SUCCESS (1.296s)
[329.947860] [091/131] (719s left) syncobj_timeline (device-signal-unordered)
[330.006676] Starting subtest: device-signal-unordered
[330.007456] Subtest device-signal-unordered: SUCCESS (0.001s)
[330.132809] [092/131] (719s left) kms_pm_rpm (cursor-dpms)
[341.645346] Subtest cursor-dpms: SKIP (0.000s)
[341.870925] [093/131] (707s left) gem_exec_params (cliprects_ptr-dirt)
[341.936560] Starting subtest: cliprects_ptr-dirt
[341.937333] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[342.092506] [094/131] (707s left) kms_psr (pr-primary-mmap-gtt)
[342.385763] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[342.589645] [095/131] (706s left) syncobj_timeline (host-signal-points)
[342.647409] Starting subtest: host-signal-points
[342.658503] Subtest host-signal-points: SUCCESS (0.011s)
[342.779947] [096/131] (706s left) kms_pipe_crc_basic (hang-read-crc)
[343.068743] Starting subtest: hang-read-crc
[343.069664] Starting dynamic subtest: pipe-A-HDMI-A-1
[344.106777] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.034s)
[344.123546] Starting dynamic subtest: pipe-B-HDMI-A-1
[345.193010] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.083s)
[345.195030] Subtest hang-read-crc: SUCCESS (2.123s)
[345.734048] [097/131] (703s left) perf (invalid-oa-format-id)
[345.890941] Subtest invalid-oa-format-id: SKIP (0.000s)
[345.966694] [098/131] (703s left) gem_mmap_gtt (basic-write-gtt)
[346.025429] Starting subtest: basic-write-gtt
[346.177859] Subtest basic-write-gtt: SUCCESS (0.152s)
[346.337590] [099/131] (703s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[346.639845] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[346.641269] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[347.040802] [100/131] (702s left) gem_sync (basic-each)
[347.115283] Starting subtest: basic-each
[349.210427] Subtest basic-each: SUCCESS (2.094s)
[349.458575] [101/131] (700s left) perf (invalid-open-flags)
[349.610775] Subtest invalid-open-flags: SKIP (0.000s)
[349.679043] [102/131] (700s left) perf_pmu (most-busy-check-all)
[349.733508] Starting subtest: most-busy-check-all
[349.734355] Starting dynamic subtest: rcs0
[350.251628] Dynamic subtest rcs0: SUCCESS (0.516s)
[350.268385] Starting dynamic subtest: bcs0
[350.777593] Dynamic subtest bcs0: SUCCESS (0.522s)
[350.794876] Starting dynamic subtest: vcs0
[351.296860] Dynamic subtest vcs0: SUCCESS (0.515s)
[351.300396] Subtest most-busy-check-all: SUCCESS (1.563s)
[351.442227] [103/131] (698s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[351.741329] Starting subtest: fbc-rgb101010-draw-render
[354.325564] Subtest fbc-rgb101010-draw-render: SUCCESS (2.581s)
[354.747988] [104/131] (695s left) gem_exec_params (dr1-dirt)
[354.806779] Starting subtest: DR1-dirt
[354.807944] Subtest DR1-dirt: SUCCESS (0.000s)
[354.974518] [105/131] (695s left) kms_cursor_crc (cursor-sliding-max-size)
[355.278632] Starting subtest: cursor-sliding-max-size
[355.281487] Subtest cursor-sliding-max-size: SKIP (0.000s)
[355.698138] [106/131] (694s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[355.759117] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[355.759963] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[355.897005] [107/131] (694s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[356.198934] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[356.411062] [108/131] (693s left) prime_mmap (test_forked)
[356.471788] Starting subtest: test_forked
[356.475224] Starting dynamic subtest: test_forked-smem
[356.485196] Dynamic subtest test_forked-smem: SUCCESS (0.016s)
[356.488645] Subtest test_forked: SUCCESS (0.019s)
[356.618863] [109/131] (693s left) gem_mmap_gtt (hang-busy)
[356.673552] Starting subtest: hang-busy
[362.929108] Subtest hang-busy: SUCCESS (6.257s)
[363.099331] [110/131] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[363.397087] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[363.398515] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[363.816632] [111/131] (686s left) gem_softpin (reverse)
[363.876129] Starting subtest: reverse
[363.882048] Subtest reverse: SUCCESS (0.006s)
[364.027683] [112/131] (686s left) kms_universal_plane (universal-plane-pageflip-windowed)
[364.319979] Starting subtest: universal-plane-pageflip-windowed
[364.321379] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[364.731016] [113/131] (685s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[365.026380] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[365.223739] [114/131] (685s left) gem_mmap_gtt (basic-wc)
[365.278179] Starting subtest: basic-wc
[365.908186] Subtest basic-wc: SUCCESS (0.630s)
[366.046574] [115/131] (684s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[366.103213] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[366.174097] [116/131] (684s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[366.226040] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[366.291129] [117/131] (684s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[366.594973] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[366.596520] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[366.998621] [118/131] (683s left) kms_flip_tiling (flip-change-tiling)
[367.297128] Starting subtest: flip-change-tiling
[367.298107] Starting dynamic subtest: pipe-A-HDMI-A-1-x-to-x
[367.491620] Dynamic subtest pipe-A-HDMI-A-1-x-to-x: SUCCESS (0.193s)
[367.511874] Starting dynamic subtest: pipe-A-HDMI-A-1-x-to-linear
[367.625034] Dynamic subtest pipe-A-HDMI-A-1-x-to-linear: SUCCESS (0.129s)
[367.641656] Starting dynamic subtest: pipe-A-HDMI-A-1-linear-to-x
[367.741726] Dynamic subtest pipe-A-HDMI-A-1-linear-to-x: SUCCESS (0.114s)
[367.758228] Starting dynamic subtest: pipe-A-HDMI-A-1-linear-to-linear
[367.858426] Dynamic subtest pipe-A-HDMI-A-1-linear-to-linear: SUCCESS (0.114s)
[367.906931] Starting dynamic subtest: pipe-B-HDMI-A-1-x-to-x
[368.253207] Dynamic subtest pipe-B-HDMI-A-1-x-to-x: SUCCESS (0.359s)
[368.270138] Starting dynamic subtest: pipe-B-HDMI-A-1-x-to-linear
[368.370214] Dynamic subtest pipe-B-HDMI-A-1-x-to-linear: SUCCESS (0.115s)
[368.390909] Starting dynamic subtest: pipe-B-HDMI-A-1-linear-to-x
[368.486027] Dynamic subtest pipe-B-HDMI-A-1-linear-to-x: SUCCESS (0.112s)
[368.503925] Starting dynamic subtest: pipe-B-HDMI-A-1-linear-to-linear
[368.602903] Dynamic subtest pipe-B-HDMI-A-1-linear-to-linear: SUCCESS (0.115s)
[368.637686] Subtest flip-change-tiling: SUCCESS (1.340s)
[369.215513] [119/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[369.516517] Starting subtest: psr-2p-primscrn-cur-indfb-move
[369.518259] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[369.928924] [120/131] (680s left) gem_mmap_gtt (big-copy-odd)
[369.988226] Starting subtest: big-copy-odd
[372.018278] Subtest big-copy-odd: SUCCESS (2.030s)
[372.199198] [121/131] (678s left) i915_pm_rpm (debugfs-forcewake-user)
[383.889514] Subtest debugfs-forcewake-user: SKIP (0.000s)
[384.097098] [122/131] (666s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[384.401065] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[384.402514] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[384.831906] [123/131] (666s left) kms_content_protection (dp-mst-lic-type-1)
[385.151891] Starting subtest: dp-mst-lic-type-1
[385.153398] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[385.569710] [124/131] (665s left) i915_pciid
[385.752886] [125/131] (665s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[385.810625] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[385.885094] [126/131] (665s left) kms_content_protection (srm)
[386.199088] Starting subtest: srm
[386.204467] Subtest srm: SKIP (0.006s)
[386.618013] [127/131] (664s left) kms_psr (psr-cursor-plane-onoff)
[386.917594] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[387.116976] [128/131] (664s left) kms_lease (empty-lease)
[387.410132] Starting subtest: empty-lease
[387.410842] Starting dynamic subtest: pipe-A-HDMI-A-1
[387.411573] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[387.428637] Starting dynamic subtest: pipe-B-HDMI-A-1
[387.429279] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[387.429923] Subtest empty-lease: SUCCESS (0.007s)
[387.819234] [129/131] (663s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[388.123412] Starting subtest: x-tiled-addfb-size-offset-overflow
[388.125108] Subtest x-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[388.541297] [130/131] (662s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[388.841026] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[388.842377] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[389.250685] [131/131] (662s left) gem_exec_create (basic)
[389.326110] Starting subtest: basic
[389.327341] Starting dynamic subtest: smem
[391.374192] Dynamic subtest smem: SUCCESS (2.048s)
[391.377868] Subtest basic: SUCCESS (2.051s)
[391.615719] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: syncobj_timeline
results: parsing output: 4/ for test: kms_color
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: kms_invalid_mode
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: kms_chamelium_color
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_userptr_blits
results: parsing output: 15/ for test: gem_ctx_shared
results: parsing output: 16/ for test: gem_busy
results: parsing output: 17/ for test: gem_pxp
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_busy
results: parsing output: 20/ for test: gem_exec_whisper
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: core_getclient
results: parsing output: 23/ for test: gem_mmap_wc
results: parsing output: 24/ for test: gem_ctx_persistence
results: parsing output: 25/ for test: kms_hdr
results: parsing output: 26/ for test: gem_eio
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_ctx_persistence
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: gem_ppgtt
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: gem_exec_capture
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: i915_pm_sseu
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_schedule
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_draw_crc
results: parsing output: 54/ for test: kms_plane_lowres
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_async_flips
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: dmabuf_sync_file
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_close_race
results: parsing output: 70/ for test: perf
results: parsing output: 71/ for test: kms_prime
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: sysfs_defaults
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_render_linear_blits
results: parsing output: 78/ for test: api_intel_allocator
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_cursor_legacy
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_suspend
results: parsing output: 84/ for test: i915_drm_fdinfo
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_chamelium_frames
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_pm_rpm
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_pipe_crc_basic
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_sync
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gem_mmap_gtt
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_universal_plane
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_flip_tiling
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: i915_pm_rpm
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: i915_pciid
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_content_protection
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_create
Done.