[70.416418] Initializing watchdogs
[70.416539]   /dev/watchdog0
[70.436997] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[70.444733] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[70.448422] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.451418] [001/131] (960s left) kms_frontbuffer_tracking (fbc-suspend)
[70.846034] Starting subtest: fbc-suspend
[107.617342] Subtest fbc-suspend: SUCCESS (4.497s)
[113.097279] [002/131] (922s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[113.182288] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[113.232624] [003/131] (922s left) gem_eio (execbuf)
[113.299199] Starting subtest: execbuf
[113.326111] Subtest execbuf: SUCCESS (0.025s)
[114.103844] [004/131] (922s left) gem_mmap_gtt (hang-busy)
[114.167581] Starting subtest: hang-busy
[114.702159] Subtest hang-busy: SUCCESS (0.519s)
[114.839130] [005/131] (921s left) kms_3d
[118.773456] [006/131] (917s left) gem_exec_reloc (basic-gtt-read)
[118.847329] Starting subtest: basic-gtt-read
[118.850637] Subtest basic-gtt-read: SUCCESS (0.003s)
[119.600994] [007/131] (916s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[119.973298] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[120.218792] [008/131] (916s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[120.587485] Starting subtest: cursorA-vs-flipB-varying-size
[120.588736] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[121.031238] [009/131] (915s left) i915_pm_rps (min-max-config-loaded)
[121.105973] Starting subtest: min-max-config-loaded
[121.436239] Subtest min-max-config-loaded: SUCCESS (0.326s)
[121.555491] [010/131] (914s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[121.937208] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[121.939170] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[122.381418] [011/131] (914s left) gem_close_race (multigpu-basic-threads)
[122.454651] Starting subtest: multigpu-basic-threads
[122.456373] Subtest multigpu-basic-threads: SKIP (0.000s)
[122.669693] [012/131] (913s left) gem_spin_batch (spin-all-new)
[122.731523] Starting subtest: spin-all-new
[122.734687] Subtest spin-all-new: SUCCESS (0.003s)
[122.935235] [013/131] (913s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[123.305667] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[123.547479] [014/131] (913s left) syncobj_timeline (single-wait-available-signaled)
[123.603644] Starting subtest: single-wait-available-signaled
[123.604326] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[123.696853] [015/131] (912s left) kms_flip (plain-flip-fb-recreate-interruptible)
[124.062993] Starting subtest: plain-flip-fb-recreate-interruptible
[124.063812] Starting dynamic subtest: A-VGA1
[133.643804] Dynamic subtest A-VGA1: FAIL (9.369s)
[133.659341] Starting dynamic subtest: B-VGA1
[141.451276] Dynamic subtest B-VGA1: SUCCESS (7.959s)
[141.463775] Starting dynamic subtest: A-HDMI-A1
[149.447657] Dynamic subtest A-HDMI-A1: SUCCESS (7.990s)
[149.459955] Starting dynamic subtest: B-HDMI-A1
[157.486309] Dynamic subtest B-HDMI-A1: SUCCESS (8.033s)
[157.487753] Subtest plain-flip-fb-recreate-interruptible: FAIL (33.357s)
[158.113162] [016/131] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[158.488043] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[158.489206] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[158.922839] [017/131] (877s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[159.286220] Starting subtest: multiplane-rotation-cropping-bottom
[159.288322] Subtest multiplane-rotation-cropping-bottom: SKIP (0.000s)
[159.729792] [018/131] (877s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[160.110856] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[160.112618] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[160.544188] [019/131] (876s left) gem_lmem_swapping (parallel-random)
[160.602003] Subtest parallel-random: SKIP (0.000s)
[160.661367] [020/131] (876s left) kms_cursor_crc (cursor-offscreen-max-size)
[161.036503] Starting subtest: cursor-offscreen-max-size
[161.038373] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[161.480492] [021/131] (875s left) gem_mmap_wc (bad-offset)
[161.533472] Starting subtest: bad-offset
[161.534229] Subtest bad-offset: SUCCESS (0.001s)
[161.628566] [022/131] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[162.002248] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[164.678829] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (2.674s)
[165.173311] [023/131] (871s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[165.546765] Starting subtest: fbc-rgb565-draw-render
[167.423503] Subtest fbc-rgb565-draw-render: SUCCESS (1.875s)
[167.908522] [024/131] (869s left) kms_flip (2x-dpms-vs-vblank-race)
[168.280076] Starting subtest: 2x-dpms-vs-vblank-race
[168.280988] Starting dynamic subtest: AB-VGA1-HDMI-A1
[178.990971] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.707s)
[178.991734] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.711s)
[179.566871] [025/131] (857s left) kms_pipe_crc_basic (suspend-read-crc)
[179.963848] Starting subtest: suspend-read-crc
[179.964501] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.881767] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.578s)
[197.893712] Starting dynamic subtest: pipe-B-HDMI-A-1
[215.881961] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.707s)
[215.882891] Subtest suspend-read-crc: SUCCESS (3.289s)
[223.440584] [026/131] (820s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[223.810037] Starting subtest: addfb25-x-tiled-mismatch-legacy
[223.810738] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[224.251053] [027/131] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[224.630331] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[224.631732] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[225.103644] [028/131] (819s left) gem_userptr_blits (forbidden-operations)
[225.162807] Starting subtest: forbidden-operations
[225.163766] Subtest forbidden-operations: SUCCESS (0.001s)
[225.303496] [029/131] (819s left) gem_ctx_isolation (preservation)
[225.368880] Starting subtest: preservation
[225.369677] Starting dynamic subtest: rcs0
[225.893095] Dynamic subtest rcs0: SUCCESS (0.508s)
[225.894030] Subtest preservation: SUCCESS (0.509s)
[226.146669] [030/131] (818s left) gem_exec_schedule (preempt-self)
[226.222486] Subtest preempt-self: SKIP (0.000s)
[226.417615] [031/131] (818s left) kms_chamelium_frames (dp-crc-fast)
[226.862376] Subtest dp-crc-fast: SKIP (0.000s)
[227.203735] [032/131] (817s left) kms_writeback (writeback-check-output)
[227.575726] Subtest writeback-check-output: SKIP (0.000s)
[227.800027] [033/131] (816s left) gem_ctx_persistence (engines-mixed-process)
[227.857544] Subtest engines-mixed-process: SKIP (0.000s)
[227.932628] [034/131] (816s left) gen7_exec_parse (basic-allowed)
[227.991121] Subtest basic-allowed: SKIP (0.000s)
[228.062517] [035/131] (816s left) kms_pm_dc (dc3co-vpb-simulation)
[239.170216] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[239.236697] [036/131] (805s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[239.604379] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[239.605101] Starting dynamic subtest: pipe-A
[239.607159] Dynamic subtest pipe-A: SKIP (0.001s)
[239.621456] Starting dynamic subtest: pipe-B
[239.623631] Dynamic subtest pipe-B: SKIP (0.001s)
[239.625377] Subtest planes-downscale-factor-0-75-upscale-20x20: SKIP (0.005s)
[240.054634] [037/131] (804s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[240.419234] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[240.664125] [038/131] (804s left) gem_pxp (create-protected-buffer)
[243.238880] Starting subtest: create-protected-buffer
[243.240605] Subtest create-protected-buffer: SKIP (0.000s)
[243.330619] [039/131] (801s left) gem_gtt_cpu_tlb
[243.493384] [040/131] (801s left) kms_vrr (max-min)
[243.858796] Starting subtest: max-min
[243.861043] Subtest max-min: SKIP (0.000s)
[244.294464] [041/131] (800s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[244.353413] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (0.000s)
[244.406368] [042/131] (800s left) perf_pmu (most-busy-check-all)
[244.462471] Starting subtest: most-busy-check-all
[244.463353] Starting dynamic subtest: rcs0
[244.982557] Dynamic subtest rcs0: SUCCESS (0.518s)
[244.996867] Starting dynamic subtest: bcs0
[245.502434] Dynamic subtest bcs0: SUCCESS (0.516s)
[245.516482] Starting dynamic subtest: vcs0
[246.021460] Dynamic subtest vcs0: SUCCESS (0.515s)
[246.024538] Subtest most-busy-check-all: SUCCESS (1.556s)
[246.113339] [043/131] (798s left) perf_pmu (interrupts-sync)
[246.170178] Starting subtest: interrupts-sync
[247.262867] Subtest interrupts-sync: SUCCESS (1.089s)
[247.369231] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true
[247.372625] [044/131] (797s left) kms_psr (pr-basic)
[247.736604] Subtest pr-basic: SKIP (0.000s)
[247.983509] [045/131] (797s left) gem_ctx_persistence (processes)
[248.040881] Subtest processes: SKIP (0.000s)
[248.111380] [046/131] (797s left) kms_getfb (getfb2-handle-protection)
[248.168743] Starting subtest: getfb2-handle-protection
[248.193923] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[248.316610] [047/131] (796s left) syncobj_wait (wait-for-submit-complex)
[248.373267] Starting subtest: wait-for-submit-complex
[248.436509] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[248.534210] [048/131] (796s left) gem_tiling_max_stride
[248.717616] [049/131] (796s left) gem_exec_reloc (basic-write-gtt-active)
[248.780124] Starting subtest: basic-write-gtt-active
[248.890150] Subtest basic-write-gtt-active: SUCCESS (0.110s)
[249.634849] [050/131] (795s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs)
[249.692637] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[249.766818] [051/131] (795s left) kms_flip (2x-flip-vs-fences)
[250.123458] Starting subtest: 2x-flip-vs-fences
[250.124340] Starting dynamic subtest: AB-VGA1-HDMI-A1
[280.486734] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.351s)
[280.489719] Subtest 2x-flip-vs-fences: SUCCESS (30.356s)
[281.142675] [052/131] (764s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[281.199484] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[281.273841] [053/131] (764s left) kms_plane (planar-pixel-format-settings)
[281.632648] Starting subtest: planar-pixel-format-settings
[281.634553] Subtest planar-pixel-format-settings: SKIP (0.000s)
[282.074878] [054/131] (763s left) kms_psr (psr2-sprite-render)
[282.435541] Subtest psr2-sprite-render: SKIP (0.000s)
[282.668354] [055/131] (762s left) gem_exec_fence (concurrent)
[282.843377] Subtest concurrent: SKIP (0.000s)
[283.220402] [056/131] (762s left) gem_softpin (allocator-nopin)
[283.277780] Subtest allocator-nopin: SKIP (0.000s)
[283.369676] [057/131] (762s left) gem_exec_balancer (indices)
[283.425074] Subtest indices: SKIP (0.000s)
[283.516271] [058/131] (762s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[283.572088] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[283.574145] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[283.670637] [059/131] (762s left) syncobj_wait (wait-for-submit-snapshot)
[283.724473] Starting subtest: wait-for-submit-snapshot
[283.807421] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[283.907545] [060/131] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[284.268660] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[284.270106] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[284.719631] [061/131] (761s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[284.777858] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[284.879986] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[284.995178] [062/131] (761s left) gem_exec_balancer (full-late-pulse)
[285.053247] Subtest full-late-pulse: SKIP (0.000s)
[285.146174] [063/131] (760s left) gem_softpin (overlap)
[285.201491] Starting subtest: overlap
[285.388012] Subtest overlap: SUCCESS (0.186s)
[285.517618] [064/131] (760s left) kms_properties (plane-properties-atomic)
[285.880314] Starting subtest: plane-properties-atomic
[285.881072] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.212979] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.331s)
[286.225791] Starting dynamic subtest: pipe-B-HDMI-A-1
[286.616035] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.400s)
[286.616960] Subtest plane-properties-atomic: SUCCESS (0.736s)
[287.159706] [065/131] (759s left) gem_eio (reset-stress)
[287.222384] Starting subtest: reset-stress
[300.112200] Subtest reset-stress: FAIL (12.844s)
[300.837753] [066/131] (745s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[301.214700] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[301.218238] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[301.665922] [067/131] (744s left) gem_mmap_gtt (hang)
[301.721268] Starting subtest: hang
[307.185733] Subtest hang: SUCCESS (5.462s)
[307.379879] [068/131] (738s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[307.740986] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[307.982319] [069/131] (738s left) gem_exec_reloc (basic-active)
[308.041164] Starting subtest: basic-active
[308.041919] Starting dynamic subtest: all-engines
[308.127649] Dynamic subtest all-engines: SUCCESS (0.086s)
[308.143094] Starting dynamic subtest: rcs0
[308.212771] Dynamic subtest rcs0: SUCCESS (0.084s)
[308.228733] Starting dynamic subtest: bcs0
[308.297906] Dynamic subtest bcs0: SUCCESS (0.083s)
[308.298848] Subtest basic-active: SUCCESS (0.258s)
[309.054273] [070/131] (737s left) kms_prop_blob (blob-prop-core)
[309.116112] Starting subtest: blob-prop-core
[309.116859] Subtest blob-prop-core: SUCCESS (0.000s)
[309.217362] [071/131] (737s left) kms_color (invalid-gamma-lut-sizes)
[309.569316] Starting subtest: invalid-gamma-lut-sizes
[309.570387] Starting dynamic subtest: pipe-A
[309.651706] Dynamic subtest pipe-A: SUCCESS (0.081s)
[309.665070] Starting dynamic subtest: pipe-B
[309.665672] Dynamic subtest pipe-B: SUCCESS (0.001s)
[309.666334] Subtest invalid-gamma-lut-sizes: SUCCESS (0.085s)
[310.191509] [072/131] (736s left) gem_exec_schedule (timeslicing)
[310.259720] Subtest timeslicing: SKIP (0.000s)
[310.465021] [073/131] (736s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[310.519015] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[310.576380] [074/131] (736s left) kms_cursor_legacy (single-bo)
[310.933748] Starting subtest: single-bo
[310.934539] Starting dynamic subtest: pipe-A
[316.319890] Dynamic subtest pipe-A: SUCCESS (5.384s)
[316.335473] Starting dynamic subtest: pipe-B
[321.711957] Dynamic subtest pipe-B: SUCCESS (5.387s)
[321.726917] Starting dynamic subtest: all-pipes
[327.097402] Dynamic subtest all-pipes: SUCCESS (5.383s)
[327.098137] Subtest single-bo: SUCCESS (16.159s)
[327.538050] [075/131] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[327.904238] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[327.905738] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[328.353374] [076/131] (718s left) kms_cursor_crc (cursor-size-change)
[328.712635] Starting subtest: cursor-size-change
[328.713380] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.333653] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.620s)
[329.351923] Starting dynamic subtest: pipe-B-HDMI-A-1
[329.996137] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.659s)
[329.996876] Subtest cursor-size-change: SUCCESS (1.284s)
[330.552636] [077/131] (716s left) i915_pm_rc6_residency (media-rc6-accuracy)
[330.610834] Starting subtest: media-rc6-accuracy
[330.612433] Subtest media-rc6-accuracy: SKIP (0.000s)
[330.717694] [078/131] (716s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[331.086731] Starting subtest: x-tiled-16bpp-rotate-90
[331.104142] Subtest x-tiled-16bpp-rotate-90: SKIP (0.016s)
[331.550017] [079/131] (715s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[331.606534] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[331.678879] [080/131] (715s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[332.029382] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[332.030731] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[332.467955] [081/131] (714s left) api_intel_allocator (two-level-inception-interruptible)
[332.527107] Starting subtest: two-level-inception-interruptible
[337.988284] Subtest two-level-inception-interruptible: SUCCESS (5.457s)
[338.084610] [082/131] (709s left) kms_sequence (get-forked-busy)
[338.441954] Starting subtest: get-forked-busy
[338.442639] Starting dynamic subtest: pipe-A-HDMI-A-1
[340.853114] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.409s)
[340.866365] Starting dynamic subtest: pipe-B-HDMI-A-1
[343.292884] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.438s)
[343.293658] Subtest get-forked-busy: SUCCESS (4.851s)
[343.850792] [083/131] (703s left) gem_mmap_gtt (basic-read-write)
[343.909219] Starting subtest: basic-read-write
[343.923805] Subtest basic-read-write: SUCCESS (0.015s)
[344.042172] [084/131] (703s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[344.415090] Starting subtest: invalid-modeset-force-ultra-joiner
[344.416422] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[344.865565] [085/131] (702s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[345.233373] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[345.235351] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[345.694328] [086/131] (701s left) gen9_exec_parse (unaligned-jump)
[345.754889] Subtest unaligned-jump: SKIP (0.000s)
[345.816632] [087/131] (701s left) syncobj_timeline (etime-single-wait-submitted)
[345.875539] Starting subtest: etime-single-wait-submitted
[345.984034] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[346.090219] [088/131] (701s left) prime_self_import (export-vs-gem_close-race)
[346.143853] Starting subtest: export-vs-gem_close-race
[351.174957] Subtest export-vs-gem_close-race: SUCCESS (5.029s)
[351.281487] [089/131] (696s left) gem_render_copy_redux (flink)
[351.340943] Starting subtest: flink
[352.435042] Subtest flink: SUCCESS (1.094s)
[352.559433] [090/131] (695s left) kms_legacy_colorkey (basic)
[352.928363] Starting subtest: basic
[352.929101] Starting dynamic subtest: pipe-A
[352.929781] Dynamic subtest pipe-A: SUCCESS (0.000s)
[352.943968] Starting dynamic subtest: pipe-B
[352.945179] Dynamic subtest pipe-B: SUCCESS (0.000s)
[352.946331] Subtest basic: SUCCESS (0.003s)
[353.381114] [091/131] (694s left) kms_psr (pr-primary-render)
[353.743430] Subtest pr-primary-render: SKIP (0.000s)
[353.975688] [092/131] (693s left) gem_mmap_wc (set-cache-level)
[354.036770] Starting subtest: set-cache-level
[354.037587] Subtest set-cache-level: SUCCESS (0.000s)
[354.170243] [093/131] (693s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[354.537510] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[355.638926] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.100s)
[356.122685] [094/131] (691s left) gem_mmap_gtt (basic)
[356.180350] Starting subtest: basic
[356.181172] Subtest basic: SUCCESS (0.001s)
[356.266609] [095/131] (691s left) sriov_basic (enable-vfs-bind-unbind-each)
[356.321979] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s)
[356.386189] [096/131] (691s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[356.765251] Starting subtest: extended-modeset-hang-newfb-with-reset
[356.766091] Starting dynamic subtest: pipe-A
[369.493175] Dynamic subtest pipe-A: SUCCESS (12.718s)
[369.507560] Starting dynamic subtest: pipe-B
[381.241561] Dynamic subtest pipe-B: SUCCESS (11.742s)
[381.242593] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (24.465s)
[381.839098] [097/131] (666s left) gem_eio (in-flight-10ms)
[381.917314] Starting subtest: in-flight-10ms
[383.349123] Subtest in-flight-10ms: SUCCESS (1.430s)
[384.111549] [098/131] (663s left) gem_exec_reloc (basic-cpu-wc-active)
[384.168996] Starting subtest: basic-cpu-wc-active
[384.280125] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[385.031132] [099/131] (663s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[385.093000] Starting subtest: yf-tiled-ccs-to-yf-tiled
[385.093715] Starting dynamic subtest: smem
[385.095150] Dynamic subtest smem: SKIP (0.000s)
[385.096630] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.001s)
[385.306605] [100/131] (662s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[385.666053] Starting subtest: primary-y-tiled-reflect-x-0
[385.667655] Subtest primary-y-tiled-reflect-x-0: SKIP (0.002s)
[386.115150] [101/131] (662s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[386.174648] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[386.237774] [102/131] (662s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[386.601562] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[386.602715] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[387.035595] [103/131] (661s left) gem_workarounds (suspend-resume-context)
[387.108505] Starting subtest: suspend-resume-context
[404.511030] Subtest suspend-resume-context: SUCCESS (0.521s)
[411.577269] [104/131] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu)
[411.972471] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu
[411.973786] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[412.450666] [105/131] (642s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation)
[412.823562] Starting subtest: plane-downscale-factor-0-25-with-rotation
[412.824551] Starting dynamic subtest: pipe-A
[412.826485] Dynamic subtest pipe-A: SKIP (0.001s)
[412.841366] Starting dynamic subtest: pipe-B
[412.844221] Dynamic subtest pipe-B: SKIP (0.001s)
[412.846013] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (0.005s)
[413.279074] [106/131] (642s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[413.659253] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[413.661905] Starting dynamic subtest: AB-VGA1-HDMI-A1
[414.290321] Dynamic subtest AB-VGA1-HDMI-A1: FAIL (0.587s)
[414.291194] Subtest 2x-flip-vs-dpms-on-nop-interruptible: FAIL (0.591s)
[414.984276] [107/131] (640s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[415.349454] Starting subtest: short-flip-after-cursor-atomic-transitions
[416.374734] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.005s)
[416.611449] [108/131] (638s left) i915_hangman (gt-engine-hang)
[416.674897] Starting subtest: gt-engine-hang
[416.676548] Subtest gt-engine-hang: SKIP (0.000s)
[416.759367] [109/131] (638s left) kms_draw_crc (draw-method-mmap-gtt)
[417.120906] Starting subtest: draw-method-mmap-gtt
[417.121681] Starting dynamic subtest: xrgb8888-untiled
[417.467148] Dynamic subtest xrgb8888-untiled: SUCCESS (0.341s)
[417.487291] Starting dynamic subtest: rgb565-untiled
[417.738708] Dynamic subtest rgb565-untiled: SUCCESS (0.264s)
[417.756145] Starting dynamic subtest: xrgb2101010-untiled
[418.010137] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.264s)
[418.027732] Starting dynamic subtest: xbgr16161616f-untiled
[418.281744] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.265s)
[418.299515] Starting dynamic subtest: xrgb8888-xtiled
[418.416874] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.131s)
[418.434950] Starting dynamic subtest: rgb565-xtiled
[418.552486] Dynamic subtest rgb565-xtiled: SUCCESS (0.131s)
[418.570141] Starting dynamic subtest: xrgb2101010-xtiled
[418.688195] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[418.708606] Starting dynamic subtest: xbgr16161616f-xtiled
[418.823627] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[418.825873] Subtest draw-method-mmap-gtt: SUCCESS (1.682s)
[419.039769] [110/131] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[419.404128] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[419.405414] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[419.498415] [111/131] (636s left) gem_fence_thrash (bo-write-verify-threaded-y)
[419.556161] Starting subtest: bo-write-verify-threaded-y
[421.649168] Subtest bo-write-verify-threaded-y: SUCCESS (2.073s)
[421.734744] [112/131] (634s left) gem_exec_fence (syncobj-import)
[421.936836] Starting subtest: syncobj-import
[421.939091] Subtest syncobj-import: SUCCESS (0.003s)
[422.263931] [113/131] (633s left) kms_content_protection (dp-mst-lic-type-1)
[422.635716] Starting subtest: dp-mst-lic-type-1
[422.637157] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[422.732316] [114/131] (633s left) api_intel_bb (object-reloc-keep-cache)
[422.788691] Starting subtest: object-reloc-keep-cache
[422.792078] Subtest object-reloc-keep-cache: SUCCESS (0.004s)
[422.882952] [115/131] (633s left) gem_exec_whisper (basic-sync)
[422.950205] Starting subtest: basic-sync
[424.272657] Subtest basic-sync: SUCCESS (1.311s)
[424.447123] [116/131] (631s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[424.803869] Starting subtest: psr-modesetfrombusy
[424.805193] Subtest psr-modesetfrombusy: SKIP (0.000s)
[424.882782] [117/131] (631s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[425.239969] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[425.241871] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[425.322209] [118/131] (630s left) gem_eio (wait-10ms)
[425.383108] Starting subtest: wait-10ms
[425.421227] Subtest wait-10ms: SUCCESS (0.038s)
[425.799738] [119/131] (630s left) kms_setmode (basic)
[425.858949] Starting subtest: basic
[425.982876] Starting dynamic subtest: pipe-A-VGA-1
[428.139697] Dynamic subtest pipe-A-VGA-1: FAIL (2.127s)
[428.186406] Starting dynamic subtest: pipe-B-VGA-1
[430.334560] Dynamic subtest pipe-B-VGA-1: FAIL (2.132s)
[430.389334] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.543468] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.157s)
[432.673293] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.803162] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.136s)
[434.942428] Starting dynamic subtest: pipe-A-VGA-1-pipe-B-HDMI-A-1
[437.211188] Dynamic subtest pipe-A-VGA-1-pipe-B-HDMI-A-1: FAIL (2.252s)
[437.364663] Starting dynamic subtest: pipe-B-VGA-1-pipe-A-HDMI-A-1
[439.624098] Dynamic subtest pipe-B-VGA-1-pipe-A-HDMI-A-1: FAIL (2.246s)
[439.740811] Subtest basic: FAIL (13.846s)
[439.969689] [120/131] (616s left) gem_exec_params (dr1-dirt)
[440.036369] Starting subtest: DR1-dirt
[440.037210] Subtest DR1-dirt: SUCCESS (0.000s)
[440.121266] [121/131] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[440.478086] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[440.479413] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[440.565808] [122/131] (615s left) kms_atomic (crtc-invalid-params-fence)
[440.913240] Starting subtest: crtc-invalid-params-fence
[440.913891] Starting dynamic subtest: pipe-A-VGA-1
[441.135261] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.221s)
[441.136197] Subtest crtc-invalid-params-fence: SUCCESS (0.224s)
[441.367396] [123/131] (615s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[441.724210] Starting subtest: cursor-rapid-movement-256x256
[441.743781] Starting dynamic subtest: pipe-A-VGA-1
[442.149648] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.405s)
[442.191052] Starting dynamic subtest: pipe-B-HDMI-A-1
[442.539847] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[442.540597] Subtest cursor-rapid-movement-256x256: SUCCESS (0.816s)
[442.780402] [124/131] (613s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[442.837965] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[442.940007] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[443.009735] [125/131] (613s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[443.065709] Starting subtest: rel-constants-invalid-rel-gen5
[443.066371] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[443.145580] [126/131] (613s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[443.501571] Starting subtest: 4-tiled-8bpp-rotate-270
[443.502866] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s)
[443.597451] [127/131] (613s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[444.041644] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[444.257663] [128/131] (612s left) syncobj_timeline (multi-wait-submitted-signaled)
[444.318980] Starting subtest: multi-wait-submitted-signaled
[444.320941] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[444.388698] [129/131] (612s left) dumb_buffer (map-valid)
[444.440338] Starting subtest: map-valid
[444.441133] Subtest map-valid: SUCCESS (0.000s)
[444.531559] [130/131] (612s left) syncobj_wait (wait-zero-handles)
[444.582190] Starting subtest: wait-zero-handles
[444.582853] Subtest wait-zero-handles: SUCCESS (0.000s)
[444.648416] [131/131] (612s left) syncobj_wait (wait-any-interrupted)
[444.703781] Starting subtest: wait-any-interrupted
[444.812158] Subtest wait-any-interrupted: SUCCESS (0.109s)
[444.875654] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_3d
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: i915_pm_rps
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_close_race
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: kms_psr2_sf
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_lmem_swapping
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_pipe_crc_basic
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: gem_ctx_isolation
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_chamelium_frames
results: parsing output: 31/ for test: kms_writeback
results: parsing output: 32/ for test: gem_ctx_persistence
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: kms_pm_dc
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_pxp
results: parsing output: 38/ for test: gem_gtt_cpu_tlb
results: parsing output: 39/ for test: kms_vrr
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: perf_pmu
results: parsing output: 42/ for test: perf_pmu
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: kms_getfb
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: gem_tiling_max_stride
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: gem_exec_fence
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: gem_exec_balancer
results: parsing output: 62/ for test: gem_softpin
results: parsing output: 63/ for test: kms_properties
results: parsing output: 64/ for test: gem_eio
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_mmap_gtt
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: kms_prop_blob
results: parsing output: 70/ for test: kms_color
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_ccs
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: i915_pm_rc6_residency
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_flip_scaled_crc
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_sequence
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: kms_joiner
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: prime_self_import
results: parsing output: 88/ for test: gem_render_copy_redux
results: parsing output: 89/ for test: kms_legacy_colorkey
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: sriov_basic
results: parsing output: 95/ for test: kms_busy
results: parsing output: 96/ for test: gem_eio
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_workarounds
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: i915_hangman
results: parsing output: 108/ for test: kms_draw_crc
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_fence_thrash
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: kms_content_protection
results: parsing output: 113/ for test: api_intel_bb
results: parsing output: 114/ for test: gem_exec_whisper
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_eio
results: parsing output: 118/ for test: kms_setmode
results: parsing output: 119/ for test: gem_exec_params
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_atomic
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: dumb_buffer
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_wait
Done.