[48.708313] Initializing watchdogs
[48.708374]   /dev/watchdog0
[48.724144] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[48.729932] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[48.732677] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[48.734482] [001/156] (960s left) kms_force_connector_basic (force-edid)
[48.862492] Starting subtest: force-edid
[49.011436] Subtest force-edid: SUCCESS (0.149s)
[49.170454] [002/156] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[49.259404] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[49.260116] Starting dynamic subtest: pipe-A-HDMI-A-1
[49.266742] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[49.272786] Starting dynamic subtest: pipe-B-HDMI-A-1
[49.279419] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[49.284988] Starting dynamic subtest: pipe-C-HDMI-A-1
[49.291608] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[49.297084] Starting dynamic subtest: pipe-D-HDMI-A-1
[49.303750] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[49.305047] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.006s)
[49.515808] [003/156] (959s left) kms_psr (fbc-psr2-cursor-plane-move)
[49.607424] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s)
[49.642934] [004/156] (959s left) gem_mmap_wc (set-cache-level)
[49.676953] Starting subtest: set-cache-level
[49.679113] Subtest set-cache-level: SUCCESS (0.003s)
[49.779683] [005/156] (959s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[49.871646] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[49.873127] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[49.997442] [006/156] (959s left) kms_vblank (query-forked)
[50.083623] Starting subtest: query-forked
[50.085091] Starting dynamic subtest: pipe-A-HDMI-A-1
[51.313507] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.229s)
[51.324499] Starting dynamic subtest: pipe-D-HDMI-A-1
[52.546367] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.228s)
[52.547090] Subtest query-forked: SUCCESS (2.463s)
[52.743625] [007/156] (956s left) gem_exec_reloc (basic-wc-read-active)
[52.787541] Starting subtest: basic-wc-read-active
[52.920120] Subtest basic-wc-read-active: SUCCESS (0.123s)
[53.037224] [008/156] (956s left) kms_rotation_crc (bad-tiling)
[53.123824] Starting subtest: bad-tiling
[54.646738] Subtest bad-tiling: SUCCESS (1.524s)
[54.803919] [009/156] (954s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[54.900796] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[54.902195] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[54.999856] [010/156] (954s left) syncobj_wait (wait-delayed-signal)
[55.034251] Starting subtest: wait-delayed-signal
[55.136773] Subtest wait-delayed-signal: SUCCESS (0.102s)
[55.227059] [011/156] (954s left) gem_exec_suspend (basic-s3)
[55.269413] Starting subtest: basic-S3
[55.270136] Starting dynamic subtest: smem
[72.676407] Dynamic subtest smem: SUCCESS (2.824s)
[72.677177] Subtest basic-S3: SUCCESS (2.825s)
[80.890765] [012/156] (936s left) gem_ctx_sseu (invalid-args)
[80.930371] Subtest invalid-args: SKIP (0.000s)
[80.968071] [013/156] (936s left) syncobj_timeline (multi-wait-all-signaled)
[81.001586] Starting subtest: multi-wait-all-signaled
[81.003217] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[81.071577] [014/156] (936s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[81.165800] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[81.167207] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[81.263547] [015/156] (936s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[81.300506] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[81.301270] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[81.374139] [016/156] (936s left) kms_prop_blob (blob-multiple)
[81.408777] Starting subtest: blob-multiple
[81.410590] Subtest blob-multiple: SUCCESS (0.002s)
[81.467105] [017/156] (936s left) kms_flip (bo-too-big-interruptible)
[81.575242] Starting subtest: bo-too-big-interruptible
[81.577034] Starting dynamic subtest: A-HDMI-A1
[82.103095] Dynamic subtest A-HDMI-A1: SUCCESS (0.525s)
[82.114758] Starting dynamic subtest: B-HDMI-A1
[82.419294] Dynamic subtest B-HDMI-A1: SUCCESS (0.313s)
[82.428281] Starting dynamic subtest: C-HDMI-A1
[82.738235] Dynamic subtest C-HDMI-A1: SUCCESS (0.317s)
[82.747758] Starting dynamic subtest: D-HDMI-A1
[83.069680] Dynamic subtest D-HDMI-A1: SUCCESS (0.329s)
[83.070540] Subtest bo-too-big-interruptible: SUCCESS (1.494s)
[83.245327] [018/156] (934s left) kms_busy (extended-modeset-hang-newfb)
[83.342325] Starting subtest: extended-modeset-hang-newfb
[83.344017] Starting dynamic subtest: pipe-A
[107.461168] Dynamic subtest pipe-A: SUCCESS (24.115s)
[107.474151] Starting dynamic subtest: pipe-D
[131.520217] Dynamic subtest pipe-D: SUCCESS (24.053s)
[131.521944] Subtest extended-modeset-hang-newfb: SUCCESS (48.175s)
[131.661638] [019/156] (886s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[132.162656] Starting subtest: syncobj-timeline-multiple-ext-nodes
[132.163725] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s)
[132.351407] [FACT gem_exec_fence (syncobj-timeline-multiple-ext-nodes)] new: kernel.kmod_is_loaded.vgem: true
[132.354371] [020/156] (885s left) syncobj_wait (reset-unsignaled)
[132.388399] Starting subtest: reset-unsignaled
[132.389152] Subtest reset-unsignaled: SUCCESS (0.000s)
[132.449192] [021/156] (885s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[132.543928] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[132.545384] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[132.631984] [022/156] (885s left) gem_exec_nop (basic-series)
[132.675328] Starting subtest: basic-series
[135.970185] Subtest basic-series: SUCCESS (3.286s)
[136.188949] [023/156] (881s left) gem_ppgtt (shrink-vs-evict-any)
[136.227923] Starting subtest: shrink-vs-evict-any
[141.334167] Subtest shrink-vs-evict-any: SUCCESS (5.069s)
[141.385057] [024/156] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[141.478069] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[141.479537] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[141.568181] [025/156] (876s left) gen7_exec_parse (chained-batch)
[141.605506] Subtest chained-batch: SKIP (0.000s)
[141.651388] [026/156] (876s left) gem_spin_batch (resubmit-all)
[141.693107] Starting subtest: resubmit-all
[141.693890] Starting dynamic subtest: rcs0
[141.697699] Dynamic subtest rcs0: SUCCESS (0.005s)
[141.706271] Starting dynamic subtest: bcs0
[141.707086] Dynamic subtest bcs0: SUCCESS (0.002s)
[141.714749] Starting dynamic subtest: vcs0
[141.715465] Dynamic subtest vcs0: SUCCESS (0.002s)
[141.722503] Starting dynamic subtest: vcs1
[141.723213] Dynamic subtest vcs1: SUCCESS (0.002s)
[141.729991] Starting dynamic subtest: vecs0
[141.730684] Dynamic subtest vecs0: SUCCESS (0.002s)
[141.731369] Subtest resubmit-all: SUCCESS (0.015s)
[141.892197] [027/156] (876s left) syncobj_timeline (wait-all-delayed-signal)
[141.925886] Starting subtest: wait-all-delayed-signal
[142.028707] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[142.130054] [028/156] (876s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[142.221692] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[142.223178] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[142.328865] [029/156] (876s left) kms_flip (2x-plain-flip-interruptible)
[142.423007] Starting subtest: 2x-plain-flip-interruptible
[142.432234] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[142.490554] [030/156] (875s left) gem_eio (in-flight-contexts-1us)
[142.536162] Starting subtest: in-flight-contexts-1us
[156.445798] Subtest in-flight-contexts-1us: SUCCESS (13.907s)
[156.580498] [031/156] (861s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[156.669507] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[156.712989] [032/156] (861s left) gem_mmap_gtt (big-bo-tiledx)
[156.746612] Starting subtest: big-bo-tiledX
[157.082310] Subtest big-bo-tiledX: SUCCESS (0.336s)
[157.201612] [033/156] (861s left) vgem_basic (create)
[157.282541] Starting subtest: create
[157.283306] Subtest create: SUCCESS (0.000s)
[157.334552] [034/156] (861s left) kms_cursor_crc (cursor-random-256x256)
[157.433062] Starting subtest: cursor-random-256x256
[157.437153] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.356893] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.920s)
[159.395017] Starting dynamic subtest: pipe-D-HDMI-A-1
[161.270302] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.885s)
[161.271092] Subtest cursor-random-256x256: SUCCESS (3.837s)
[161.409392] [035/156] (857s left) kms_frontbuffer_tracking (fbc-stridechange)
[161.508581] Starting subtest: fbc-stridechange
[162.488691] Subtest fbc-stridechange: SUCCESS (0.980s)
[162.608182] [036/156] (856s left) gem_ctx_persistence (saturated-hostile)
[162.649167] Starting subtest: saturated-hostile
[162.649863] Starting dynamic subtest: rcs0
[163.392290] Dynamic subtest rcs0: SUCCESS (0.735s)
[163.403843] Starting dynamic subtest: bcs0
[164.145612] Dynamic subtest bcs0: SUCCESS (0.752s)
[164.156942] Starting dynamic subtest: vcs0
[164.903675] Dynamic subtest vcs0: SUCCESS (0.756s)
[164.914883] Starting dynamic subtest: vcs1
[165.671535] Dynamic subtest vcs1: SUCCESS (0.766s)
[165.682670] Starting dynamic subtest: vecs0
[166.424199] Dynamic subtest vecs0: SUCCESS (0.752s)
[166.425196] Subtest saturated-hostile: SUCCESS (3.768s)
[166.552630] [037/156] (852s left) gem_partial_pwrite_pread (write-display)
[166.591647] Starting subtest: write-display
[177.019479] Subtest write-display: SUCCESS (10.428s)
[177.134943] [038/156] (841s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[177.225437] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[177.227187] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.234321] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[177.242513] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.249576] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[177.257724] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.264766] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[177.272674] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.279481] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[177.280823] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[177.478757] [039/156] (841s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-wc)
[177.572769] Starting subtest: hdr-rgb565-draw-mmap-wc
[177.574172] Subtest hdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[177.671825] [040/156] (841s left) kms_lease (implicit-plane-lease)
[177.759404] Starting subtest: implicit-plane-lease
[177.761226] Subtest implicit-plane-lease: SUCCESS (0.002s)
[177.819626] [041/156] (841s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[177.908467] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[177.909940] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[177.977565] [042/156] (840s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[178.071249] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[178.072672] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[178.155702] [043/156] (840s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[178.247869] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[178.249281] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[178.348665] [044/156] (840s left) kms_big_fb (linear-16bpp-rotate-90)
[178.449325] Starting subtest: linear-16bpp-rotate-90
[178.527095] Subtest linear-16bpp-rotate-90: SKIP (0.077s)
[178.650405] [045/156] (840s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[178.743905] Starting subtest: fbchdr-2p-rte
[178.745385] Subtest fbchdr-2p-rte: SKIP (0.000s)
[178.839398] [046/156] (840s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[178.932898] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[178.934350] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[179.040672] [047/156] (840s left) i915_query (query-topology-garbage-items)
[179.075493] Starting subtest: query-topology-garbage-items
[179.076207] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[179.140397] [048/156] (839s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[179.232932] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[179.234421] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[179.341879] [049/156] (839s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[179.485163] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[179.588433] [050/156] (839s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[179.676635] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[179.678652] Starting dynamic subtest: pipe-A-valid-mode
[180.907950] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.230s)
[180.908652] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.232s)
[181.067397] [051/156] (838s left) kms_vblank (query-idle-hang)
[181.159419] Starting subtest: query-idle-hang
[181.161524] Starting dynamic subtest: pipe-A-HDMI-A-1
[195.463909] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.303s)
[195.476729] Starting dynamic subtest: pipe-D-HDMI-A-1
[209.277336] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.808s)
[209.278101] Subtest query-idle-hang: SUCCESS (28.119s)
[209.457579] [052/156] (809s left) gem_mmap_offset (clear)
[209.493603] Starting subtest: clear
[209.498114] Starting dynamic subtest: smem0
[231.778468] Dynamic subtest smem0: SUCCESS (22.284s)
[231.779173] Subtest clear: SUCCESS (22.285s)
[231.906404] [053/156] (787s left) i915_hangman (engine-engine-error)
[232.008216] Starting subtest: engine-engine-error
[232.008937] Starting dynamic subtest: rcs0
[232.068349] Dynamic subtest rcs0: SUCCESS (0.060s)
[232.090847] Starting dynamic subtest: bcs0
[232.139477] Dynamic subtest bcs0: SUCCESS (0.068s)
[232.159017] Starting dynamic subtest: vcs0
[232.209373] Dynamic subtest vcs0: SUCCESS (0.067s)
[232.226721] Starting dynamic subtest: vcs1
[232.281710] Dynamic subtest vcs1: SUCCESS (0.069s)
[232.303685] Starting dynamic subtest: vecs0
[232.364510] Dynamic subtest vecs0: SUCCESS (0.080s)
[232.365842] Subtest engine-engine-error: SUCCESS (0.358s)
[232.488213] [054/156] (786s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[232.588262] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[232.589676] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[232.687382] [055/156] (786s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[232.780479] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[232.781815] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[232.877161] [056/156] (786s left) kms_psr (psr-sprite-plane-onoff)
[232.966395] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[233.013652] [057/156] (786s left) kms_psr (fbc-pr-primary-mmap-gtt)
[233.102190] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[233.146817] [058/156] (786s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[233.242344] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[233.243727] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[233.336366] [059/156] (786s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[233.426364] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[233.427771] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s)
[233.495305] [060/156] (786s left) kms_cursor_crc (cursor-offscreen-32x32)
[233.591265] Starting subtest: cursor-offscreen-32x32
[233.643733] Subtest cursor-offscreen-32x32: SKIP (0.051s)
[233.724360] [061/156] (785s left) gem_exec_schedule (noreorder-corked)
[233.894665] Starting subtest: noreorder-corked
[233.895782] Starting dynamic subtest: rcs0
[235.009867] Dynamic subtest rcs0: SUCCESS (1.114s)
[235.022678] Starting dynamic subtest: bcs0
[236.137412] Dynamic subtest bcs0: SUCCESS (1.126s)
[236.149998] Starting dynamic subtest: vcs0
[237.258272] Dynamic subtest vcs0: SUCCESS (1.118s)
[237.272710] Starting dynamic subtest: vcs1
[238.380264] Dynamic subtest vcs1: SUCCESS (1.119s)
[238.394198] Starting dynamic subtest: vecs0
[239.498211] Dynamic subtest vecs0: SUCCESS (1.116s)
[239.499615] Subtest noreorder-corked: SUCCESS (5.605s)
[239.686448] [062/156] (779s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[239.721086] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[239.721809] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[239.802713] [063/156] (779s left) gem_render_copy_redux (normal)
[239.841656] Starting subtest: normal
[240.169103] Subtest normal: SUCCESS (0.318s)
[240.284997] [064/156] (779s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[240.379739] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[240.381151] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[240.482253] [065/156] (779s left) kms_psr (pr-cursor-plane-move)
[240.571377] Subtest pr-cursor-plane-move: SKIP (0.000s)
[240.616086] [066/156] (779s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[240.717928] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[240.719399] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[240.824899] [067/156] (779s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[240.922328] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[240.930842] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[241.007843] [068/156] (778s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[241.099458] Starting subtest: cursorA-vs-flipA-toggle
[251.959748] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.859s)
[252.097879] [069/156] (767s left) kms_psr (psr-primary-mmap-gtt)
[252.196065] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[252.239253] [070/156] (767s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[252.331888] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[252.333258] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[252.440797] [071/156] (767s left) gem_exec_reloc (basic-active)
[252.480014] Starting subtest: basic-active
[252.480751] Starting dynamic subtest: all-engines
[252.579891] Dynamic subtest all-engines: SUCCESS (0.099s)
[252.591602] Starting dynamic subtest: rcs0
[252.640918] Dynamic subtest rcs0: SUCCESS (0.060s)
[252.651612] Starting dynamic subtest: bcs0
[252.699701] Dynamic subtest bcs0: SUCCESS (0.058s)
[252.710044] Starting dynamic subtest: vcs0
[252.758875] Dynamic subtest vcs0: SUCCESS (0.058s)
[252.769703] Starting dynamic subtest: vcs1
[252.816190] Dynamic subtest vcs1: SUCCESS (0.056s)
[252.827059] Starting dynamic subtest: vecs0
[252.874432] Dynamic subtest vecs0: SUCCESS (0.057s)
[252.875290] Subtest basic-active: SUCCESS (0.395s)
[252.993482] [072/156] (767s left) gem_userptr_blits (sync-unmap)
[253.039837] Starting subtest: sync-unmap
[253.056020] Subtest sync-unmap: SUCCESS (0.016s)
[253.194224] [073/156] (766s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[253.286937] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[254.557200] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.271s)
[254.684797] [074/156] (765s left) gem_mmap (basic)
[254.720265] Starting subtest: basic
[254.723784] Subtest basic: SUCCESS (0.000s)
[254.812409] [075/156] (765s left) sw_sync (alloc_merge_fence)
[254.846788] Starting subtest: alloc_merge_fence
[254.847510] Subtest alloc_merge_fence: SUCCESS (0.000s)
[254.918117] [076/156] (765s left) kms_getfb (getfb-handle-not-fb)
[255.010565] Starting subtest: getfb-handle-not-fb
[255.011300] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[255.106171] [077/156] (765s left) kms_cursor_edge_walk (64x64-top-edge)
[255.203889] Starting subtest: 64x64-top-edge
[255.204609] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.961527] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.765s)
[256.972835] Starting dynamic subtest: pipe-D-HDMI-A-1
[258.675027] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.709s)
[258.675781] Subtest 64x64-top-edge: SUCCESS (3.479s)
[258.792382] [078/156] (761s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt)
[258.896856] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt
[258.898238] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[258.989732] [079/156] (761s left) gem_barrier_race (remote-request)
[259.037591] Starting subtest: remote-request
[259.038322] Starting dynamic subtest: rcs0
[264.124857] Dynamic subtest rcs0: SUCCESS (5.087s)
[264.126132] Subtest remote-request: SUCCESS (5.088s)
[264.279623] [080/156] (756s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt)
[264.379554] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt
[264.380935] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[264.486753] [081/156] (756s left) perf_pmu (most-busy-idle-check-all)
[264.524359] Starting subtest: most-busy-idle-check-all
[264.525215] Starting dynamic subtest: rcs0
[265.145877] Dynamic subtest rcs0: SUCCESS (0.619s)
[265.157285] Starting dynamic subtest: bcs0
[265.764482] Dynamic subtest bcs0: SUCCESS (0.617s)
[265.780436] Starting dynamic subtest: vcs0
[266.383759] Dynamic subtest vcs0: SUCCESS (0.617s)
[266.397414] Starting dynamic subtest: vcs1
[267.003756] Dynamic subtest vcs1: SUCCESS (0.617s)
[267.016403] Starting dynamic subtest: vecs0
[267.624636] Dynamic subtest vecs0: SUCCESS (0.619s)
[267.627865] Subtest most-busy-idle-check-all: SUCCESS (3.101s)
[267.711113] [082/156] (752s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[267.746372] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[267.747148] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[267.805694] [083/156] (752s left) kms_content_protection (legacy)
[267.901909] Starting subtest: legacy
[267.908172] Subtest legacy: SKIP (0.004s)
[268.000247] [084/156] (752s left) api_intel_bb (simple-bb-ctx)
[268.034764] Starting subtest: simple-bb-ctx
[268.038179] Subtest simple-bb-ctx: SUCCESS (0.004s)
[268.161974] [085/156] (752s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[268.254346] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[268.255707] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[268.353279] [086/156] (752s left) kms_chamelium_color (ctm-red-to-blue)
[268.445707] Subtest ctm-red-to-blue: SKIP (0.000s)
[268.487521] [087/156] (752s left) gem_exec_whisper (basic-queues)
[268.536656] Starting subtest: basic-queues
[270.240675] Subtest basic-queues: SUCCESS (1.703s)
[270.438801] [088/156] (750s left) kms_async_flips (alternate-sync-async-flip-atomic)
[270.530483] Starting subtest: alternate-sync-async-flip-atomic
[270.662897] Starting dynamic subtest: pipe-A-HDMI-A-1
[272.781604] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.109s)
[272.910730] Starting dynamic subtest: pipe-B-HDMI-A-1
[275.008348] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.099s)
[275.129314] Starting dynamic subtest: pipe-C-HDMI-A-1
[277.216063] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.086s)
[277.347291] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.453208] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.106s)
[279.453926] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.915s)
[279.695038] [089/156] (741s left) gem_exec_params (dr1-dirt)
[279.736639] Starting subtest: DR1-dirt
[279.737422] Subtest DR1-dirt: SUCCESS (0.000s)
[279.832816] [090/156] (741s left) gem_mmap_wc (write-gtt-read-wc)
[279.868176] Starting subtest: write-gtt-read-wc
[280.183341] Subtest write-gtt-read-wc: SUCCESS (0.308s)
[280.268883] [091/156] (740s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[280.366019] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[280.367457] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[280.467572] [092/156] (740s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[280.556620] Starting subtest: primary-yf-tiled-reflect-x-0
[280.609561] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.052s)
[280.696257] [093/156] (740s left) gem_ctx_param (vm)
[280.730566] Starting subtest: vm
[280.750963] Subtest vm: SUCCESS (0.020s)
[280.888068] [094/156] (740s left) gem_exec_balancer (fairslice)
[280.929776] Starting subtest: fairslice
[284.259888] Subtest fairslice: SUCCESS (3.321s)
[284.444887] [095/156] (736s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[284.537497] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[284.538924] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[284.597785] [096/156] (736s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[284.692535] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[284.694016] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[284.803448] [097/156] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[284.898483] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[284.899822] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[285.001482] [098/156] (736s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[285.041587] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[285.042352] Starting dynamic subtest: smem
[285.117348] Dynamic subtest smem: SUCCESS (0.075s)
[285.118183] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (0.076s)
[285.331462] [099/156] (735s left) vgem_basic (bad-handle)
[285.368238] Starting subtest: bad-handle
[285.368923] Subtest bad-handle: SUCCESS (0.000s)
[285.436283] [100/156] (735s left) syncobj_wait (multi-wait-all-submitted)
[285.470536] Starting subtest: multi-wait-all-submitted
[285.572189] Subtest multi-wait-all-submitted: SUCCESS (0.101s)
[285.651338] [101/156] (735s left) kms_cursor_legacy (torture-bo)
[285.741263] Starting subtest: torture-bo
[285.741994] Starting dynamic subtest: pipe-A
[291.248867] Dynamic subtest pipe-A: SUCCESS (5.473s)
[291.259348] Starting dynamic subtest: pipe-B
[296.722315] Dynamic subtest pipe-B: SUCCESS (5.472s)
[296.733581] Starting dynamic subtest: pipe-C
[302.206313] Dynamic subtest pipe-C: SUCCESS (5.482s)
[302.216756] Starting dynamic subtest: pipe-D
[307.677391] Dynamic subtest pipe-D: SUCCESS (5.470s)
[307.688665] Starting dynamic subtest: all-pipes
[313.156414] Dynamic subtest all-pipes: SUCCESS (5.478s)
[313.157134] Subtest torture-bo: SUCCESS (27.381s)
[313.227298] [102/156] (708s left) kms_concurrent (multi-plane-atomic-lowres)
[313.330519] Starting subtest: multi-plane-atomic-lowres
[313.332316] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.689304] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.357s)
[313.701701] Starting dynamic subtest: pipe-B-HDMI-A-1
[314.060067] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.369s)
[314.071296] Starting dynamic subtest: pipe-C-HDMI-A-1
[314.432534] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.369s)
[314.443844] Starting dynamic subtest: pipe-D-HDMI-A-1
[314.812488] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.379s)
[314.813228] Subtest multi-plane-atomic-lowres: SUCCESS (1.482s)
[314.936045] [103/156] (706s left) gem_ctx_exec (basic)
[314.974911] Starting subtest: basic
[314.977542] Subtest basic: SUCCESS (0.002s)
[315.103681] [104/156] (706s left) i915_pm_rps (reset)
[315.143154] Starting subtest: reset
[319.681214] Subtest reset: SUCCESS (4.532s)
[319.768661] [105/156] (701s left) prime_vgem (sync)
[319.831782] Starting subtest: sync
[319.832536] Starting dynamic subtest: rcs0
[319.865915] Dynamic subtest rcs0: SUCCESS (0.035s)
[319.880422] Starting dynamic subtest: bcs0
[319.885397] Dynamic subtest bcs0: SUCCESS (0.018s)
[319.897647] Starting dynamic subtest: vcs0
[319.904079] Dynamic subtest vcs0: SUCCESS (0.017s)
[319.915009] Starting dynamic subtest: vcs1
[319.921458] Dynamic subtest vcs1: SUCCESS (0.016s)
[319.932905] Starting dynamic subtest: vecs0
[319.936431] Dynamic subtest vecs0: SUCCESS (0.014s)
[319.937239] Subtest sync: SUCCESS (0.107s)
[320.043240] [106/156] (701s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[320.139025] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[320.140462] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[320.223268] [107/156] (701s left) gem_mmap_wc (coherency)
[320.258057] Starting subtest: coherency
[320.315625] Subtest coherency: SUCCESS (0.059s)
[320.397242] [108/156] (701s left) gem_userptr_blits (stress-purge)
[320.443669] Starting subtest: stress-purge
[325.822284] Subtest stress-purge: SUCCESS (5.378s)
[325.956825] [109/156] (695s left) kms_fb_coherency (memset-crc)
[326.110434] Starting subtest: memset-crc
[326.111238] Starting dynamic subtest: mmap-gtt
[326.362681] Dynamic subtest mmap-gtt: SUCCESS (0.251s)
[326.437568] Starting dynamic subtest: mmap-offset-wc
[326.637103] Dynamic subtest mmap-offset-wc: SUCCESS (0.208s)
[326.713854] Starting dynamic subtest: mmap-offset-uc
[327.283673] Dynamic subtest mmap-offset-uc: SUCCESS (0.578s)
[327.351913] Starting dynamic subtest: mmap-legacy-wc
[327.566817] Dynamic subtest mmap-legacy-wc: SUCCESS (0.223s)
[327.635853] Subtest memset-crc: SUCCESS (1.525s)
[327.789870] [110/156] (694s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[327.885509] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[327.886221] Starting dynamic subtest: pipe-A
[328.257521] Dynamic subtest pipe-A: SUCCESS (0.372s)
[328.279227] Starting dynamic subtest: pipe-B
[328.717080] Dynamic subtest pipe-B: SUCCESS (0.458s)
[328.730576] Starting dynamic subtest: pipe-C
[329.161576] Dynamic subtest pipe-C: SUCCESS (0.443s)
[329.182086] Starting dynamic subtest: pipe-D
[329.613669] Dynamic subtest pipe-D: SUCCESS (0.451s)
[329.614383] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (1.729s)
[329.800698] [111/156] (692s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[329.898597] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[362.017391] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (32.120s)
[362.167995] [112/156] (659s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[362.267861] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[362.269255] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[362.376473] [113/156] (659s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[362.416217] Starting subtest: yf-tiled-to-vebox-y-tiled
[362.416991] Starting dynamic subtest: smem
[362.513193] Dynamic subtest smem: SUCCESS (0.096s)
[362.513958] Subtest yf-tiled-to-vebox-y-tiled: SUCCESS (0.098s)
[362.701533] [114/156] (659s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[362.795314] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[362.796699] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[362.901895] [115/156] (659s left) kms_hdr (static-toggle)
[362.991893] Starting subtest: static-toggle
[362.992624] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB2101010
[362.994048] Dynamic subtest pipe-A-HDMI-A-1-XRGB2101010: SKIP (0.000s)
[363.004308] Starting dynamic subtest: pipe-A-HDMI-A-1-XRGB16161616F
[363.005697] Dynamic subtest pipe-A-HDMI-A-1-XRGB16161616F: SKIP (0.000s)
[363.007110] Subtest static-toggle: SKIP (0.005s)
[363.055345] [116/156] (659s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[363.148403] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s)
[363.193596] [117/156] (658s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[363.287246] Starting subtest: fbc-rgb565-draw-mmap-cpu
[364.543886] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (1.257s)
[364.668628] [118/156] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[364.764835] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[364.766208] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[364.868011] [119/156] (657s left) kms_plane_cursor (primary)
[364.956942] Starting subtest: primary
[364.958518] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[366.168652] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.210s)
[366.209356] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[367.410442] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.216s)
[367.453915] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[368.660839] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.224s)
[368.745185] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[369.997263] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.261s)
[370.027152] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[371.230703] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.216s)
[371.263691] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[372.464291] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.216s)
[372.541233] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[373.795058] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.263s)
[373.826365] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[375.028313] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.216s)
[375.060133] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[376.261141] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.216s)
[376.341360] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[377.604730] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.272s)
[377.631579] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[378.829970] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.208s)
[378.863676] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[380.063399] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.216s)
[380.131727] Subtest primary: SUCCESS (15.175s)
[380.263868] [120/156] (641s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[380.363598] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[380.365003] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[380.452538] [121/156] (641s left) i915_drm_fdinfo (context-close-stress)
[380.491401] Starting subtest: context-close-stress
[391.271977] Subtest context-close-stress: SUCCESS (10.746s)
[391.307384] [122/156] (631s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[391.403499] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[391.405315] Starting dynamic subtest: pipe-A-HDMI-A-1
[391.412198] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[391.422211] Starting dynamic subtest: pipe-B-HDMI-A-1
[391.428980] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[391.438983] Starting dynamic subtest: pipe-C-HDMI-A-1
[391.445751] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[391.455429] Starting dynamic subtest: pipe-D-HDMI-A-1
[391.462440] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[391.463862] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s)
[391.667564] [123/156] (630s left) gem_exec_balancer (sequential)
[391.711590] Starting subtest: sequential
[395.184571] Subtest sequential: SUCCESS (3.473s)
[395.376562] [124/156] (627s left) gem_eio (in-flight-immediate)
[395.419952] Starting subtest: in-flight-immediate
[397.667147] Subtest in-flight-immediate: SUCCESS (2.247s)
[397.794334] [125/156] (624s left) syncobj_wait (signal)
[397.837755] Starting subtest: signal
[397.838564] Subtest signal: SUCCESS (0.000s)
[397.900789] [126/156] (624s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-move)
[397.994923] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-move
[397.996345] Subtest psrhdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[398.106698] [127/156] (624s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[398.200788] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[398.202215] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[398.315592] [128/156] (624s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[398.406920] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[398.454131] [129/156] (624s left) gem_pread (snoop)
[398.488024] Starting subtest: snoop
[399.310259] Subtest snoop: SUCCESS (0.813s)
[399.400117] [130/156] (623s left) gem_cs_tlb (engines)
[399.437415] Starting subtest: engines
[399.438184] Starting dynamic subtest: rcs0
[401.597166] Dynamic subtest rcs0: SUCCESS (2.150s)
[401.606925] Starting dynamic subtest: bcs0
[403.748365] Dynamic subtest bcs0: SUCCESS (2.150s)
[403.758160] Starting dynamic subtest: vcs0
[405.899357] Dynamic subtest vcs0: SUCCESS (2.150s)
[405.909189] Starting dynamic subtest: vcs1
[408.049943] Dynamic subtest vcs1: SUCCESS (2.149s)
[408.059642] Starting dynamic subtest: vecs0
[410.200863] Dynamic subtest vecs0: SUCCESS (2.150s)
[410.201546] Subtest engines: SUCCESS (10.755s)
[410.301353] [131/156] (612s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[410.397718] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[410.399136] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[410.495618] [132/156] (612s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[410.585542] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[410.587755] Starting dynamic subtest: pipe-A-HDMI-A-1
[410.605834] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[410.617617] Starting dynamic subtest: pipe-B-HDMI-A-1
[410.636617] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[410.649307] Starting dynamic subtest: pipe-C-HDMI-A-1
[410.667536] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[410.678065] Starting dynamic subtest: pipe-D-HDMI-A-1
[410.695594] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[410.696979] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.016s)
[410.865969] [133/156] (611s left) prime_vgem (fence-write-hang)
[410.942324] Subtest fence-write-hang: SKIP (0.000s)
[411.054815] [134/156] (611s left) i915_query (query-topology-kernel-writes)
[411.089804] Starting subtest: query-topology-kernel-writes
[411.090599] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[411.164168] [135/156] (611s left) kms_pm_dc (dc6-dpms)
[412.264660] Starting subtest: dc6-dpms
[415.610680] Subtest dc6-dpms: FAIL (3.331s)
[415.724812] [136/156] (607s left) perf_pmu (busy)
[415.764264] Starting subtest: busy
[415.764962] Starting dynamic subtest: rcs0
[416.318905] Dynamic subtest rcs0: SUCCESS (0.555s)
[416.332867] Starting dynamic subtest: bcs0
[416.851893] Dynamic subtest bcs0: SUCCESS (0.530s)
[416.865774] Starting dynamic subtest: vcs0
[417.383336] Dynamic subtest vcs0: SUCCESS (0.529s)
[417.396735] Starting dynamic subtest: vcs1
[417.924992] Dynamic subtest vcs1: SUCCESS (0.539s)
[417.938386] Starting dynamic subtest: vecs0
[418.472117] Dynamic subtest vecs0: SUCCESS (0.545s)
[418.476472] Subtest busy: SUCCESS (2.710s)
[418.549885] [137/156] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[418.646843] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[418.648259] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[418.745578] [138/156] (604s left) syncobj_wait (invalid-signal-bad-pad)
[418.779540] Starting subtest: invalid-signal-bad-pad
[418.780306] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[418.846718] [139/156] (604s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[418.952099] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[418.953513] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[419.038527] [140/156] (604s left) gem_exec_schedule (preempt-user)
[419.086404] Starting subtest: preempt-user
[419.087178] Starting dynamic subtest: rcs0
[419.106075] Dynamic subtest rcs0: SUCCESS (0.019s)
[419.117904] Starting dynamic subtest: bcs0
[419.124871] Dynamic subtest bcs0: SUCCESS (0.018s)
[419.137995] Starting dynamic subtest: vcs0
[419.144571] Dynamic subtest vcs0: SUCCESS (0.019s)
[419.156796] Starting dynamic subtest: vcs1
[419.163820] Dynamic subtest vcs1: SUCCESS (0.018s)
[419.177040] Starting dynamic subtest: vecs0
[419.182933] Dynamic subtest vecs0: SUCCESS (0.018s)
[419.183660] Subtest preempt-user: SUCCESS (0.097s)
[419.501962] [141/156] (603s left) gem_sync (basic-store-all)
[419.545736] Starting subtest: basic-store-all
[421.885445] Subtest basic-store-all: SUCCESS (2.340s)
[422.074020] [142/156] (601s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[422.174751] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[422.865639] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.690s)
[422.997599] [143/156] (600s left) gem_lmem_swapping (parallel-random-verify-ccs)
[423.034992] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[423.086717] [144/156] (600s left) syncobj_eventfd (invalid-illegal-eventfd)
[423.120827] Starting subtest: invalid-illegal-eventfd
[423.121572] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[423.191461] [145/156] (600s left) gem_lmem_evict (dontneed-evict-race)
[423.230868] Subtest dontneed-evict-race: SKIP (0.000s)
[423.273184] [146/156] (600s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[423.377984] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[423.379497] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[423.454295] [147/156] (599s left) kms_async_flips (test-cursor-atomic)
[423.544606] Starting subtest: test-cursor-atomic
[423.665645] Starting dynamic subtest: pipe-A-HDMI-A-1
[423.765646] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.100s)
[423.906566] Starting dynamic subtest: pipe-B-HDMI-A-1
[423.986346] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.091s)
[424.106221] Starting dynamic subtest: pipe-C-HDMI-A-1
[424.175100] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.082s)
[424.310489] Starting dynamic subtest: pipe-D-HDMI-A-1
[424.389307] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.088s)
[424.390055] Subtest test-cursor-atomic: SUCCESS (0.846s)
[424.667379] [148/156] (598s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-pwrite)
[424.765554] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-pwrite
[424.766991] Subtest hdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[424.873891] [149/156] (598s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[424.967551] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[424.968987] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[425.063267] [150/156] (598s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[425.161558] Starting subtest: x-tiled-16bpp-rotate-270
[425.240612] Subtest x-tiled-16bpp-rotate-270: SKIP (0.078s)
[425.366154] [151/156] (598s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[425.461321] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[425.462718] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[425.567942] [152/156] (598s left) kms_chamelium_frames (dp-crc-fast)
[425.709594] Subtest dp-crc-fast: SKIP (0.000s)
[425.828016] [153/156] (597s left) core_setmaster (master-drop-set-root)
[425.891182] Starting subtest: master-drop-set-root
[425.903009] Subtest master-drop-set-root: SUCCESS (0.012s)
[425.949255] [154/156] (597s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[426.036521] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[426.037464] Starting dynamic subtest: pipe-A
[427.269805] Dynamic subtest pipe-A: SUCCESS (1.233s)
[427.281883] Starting dynamic subtest: pipe-B
[428.578146] Dynamic subtest pipe-B: SUCCESS (1.307s)
[428.591174] Starting dynamic subtest: pipe-C
[428.788220] Dynamic subtest pipe-C: SUCCESS (0.209s)
[428.799425] Starting dynamic subtest: pipe-D
[428.996895] Dynamic subtest pipe-D: SUCCESS (0.208s)
[428.997648] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (2.961s)
[429.190723] [155/156] (594s left) kms_lease (master-vs-lease)
[429.285598] Starting subtest: master-vs-lease
[429.286313] Subtest master-vs-lease: SUCCESS (0.001s)
[429.343210] [156/156] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[429.435680] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[429.437062] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[429.538370] Closing watchdogs
results: parsing output: 0/ for test: kms_force_connector_basic
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_mmap_wc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_vblank
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: kms_rotation_crc
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: syncobj_wait
results: parsing output: 10/ for test: gem_exec_suspend
results: parsing output: 11/ for test: gem_ctx_sseu
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_prop_blob
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_busy
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_nop
results: parsing output: 22/ for test: gem_ppgtt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: gem_spin_batch
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_mmap_gtt
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_cursor_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: gem_partial_pwrite_pread
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_chamelium_hpd
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: gem_mmap_offset
results: parsing output: 52/ for test: i915_hangman
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_render_copy_redux
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_userptr_blits
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_mmap
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: kms_cursor_edge_walk
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_barrier_race
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: perf_pmu
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_content_protection
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: gem_mmap_wc
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_rotation_crc
results: parsing output: 92/ for test: gem_ctx_param
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: kms_plane
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: syncobj_wait
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_concurrent
results: parsing output: 102/ for test: gem_ctx_exec
results: parsing output: 103/ for test: i915_pm_rps
results: parsing output: 104/ for test: prime_vgem
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_fb_coherency
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_hdr
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_plane_cursor
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: syncobj_wait
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: gem_pread
results: parsing output: 129/ for test: gem_cs_tlb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_ccs
results: parsing output: 132/ for test: prime_vgem
results: parsing output: 133/ for test: i915_query
results: parsing output: 134/ for test: kms_pm_dc
results: parsing output: 135/ for test: perf_pmu
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: syncobj_wait
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_sync
results: parsing output: 141/ for test: kms_big_fb
results: parsing output: 142/ for test: gem_lmem_swapping
results: parsing output: 143/ for test: syncobj_eventfd
results: parsing output: 144/ for test: gem_lmem_evict
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_async_flips
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_big_fb
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_chamelium_frames
results: parsing output: 152/ for test: core_setmaster
results: parsing output: 153/ for test: kms_plane_scaling
results: parsing output: 154/ for test: kms_lease
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.