[57.269195] Initializing watchdogs
[57.269247]   /dev/watchdog0
[57.284339] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.288640] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.291096] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.294619] [001/133] (960s left) kms_pm_rpm (fences)
[62.180999] Starting subtest: fences
[62.186145] Subtest fences: SKIP (0.000s)
[62.882606] [002/133] (954s left) i915_query (query-topology-coherent-slice-mask)
[62.940592] Starting subtest: query-topology-coherent-slice-mask
[62.944580] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[63.046877] [003/133] (954s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[63.126324] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[63.128627] Starting dynamic subtest: pipe-A-eDP-1
[63.154253] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.163510] Starting dynamic subtest: pipe-B-eDP-1
[63.187214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.194748] Starting dynamic subtest: pipe-C-eDP-1
[63.218635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.225949] Starting dynamic subtest: pipe-D-eDP-1
[63.250064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.254175] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[65.452085] [004/133] (952s left) gem_exec_schedule (fairslice)
[65.520724] Starting subtest: fairslice
[65.522976] Starting dynamic subtest: rcs0
[67.537047] Dynamic subtest rcs0: SUCCESS (2.020s)
[67.547805] Starting dynamic subtest: bcs0
[69.558923] Dynamic subtest bcs0: SUCCESS (2.023s)
[69.566095] Starting dynamic subtest: vcs0
[71.585900] Dynamic subtest vcs0: SUCCESS (2.026s)
[71.594633] Starting dynamic subtest: vcs1
[73.608413] Dynamic subtest vcs1: SUCCESS (2.020s)
[73.616593] Starting dynamic subtest: vecs0
[75.625636] Dynamic subtest vecs0: SUCCESS (2.018s)
[75.634234] Starting dynamic subtest: ccs0
[77.647544] Dynamic subtest ccs0: SUCCESS (2.020s)
[77.649795] Subtest fairslice: SUCCESS (12.129s)
[77.937139] [005/133] (940s left) kms_cursor_edge_walk (256x256-right-edge)
[78.039811] Starting subtest: 256x256-right-edge
[78.042251] Starting dynamic subtest: pipe-A-eDP-1
[81.502050] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s)
[81.510714] Starting dynamic subtest: pipe-D-eDP-1
[84.613493] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.111s)
[84.616076] Subtest 256x256-right-edge: SUCCESS (6.574s)
[85.418124] [006/133] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[85.529662] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[92.489308] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.961s)
[92.621012] [007/133] (925s left) gem_eio (in-flight-immediate)
[92.840949] Starting subtest: in-flight-immediate
[101.528440] Subtest in-flight-immediate: SUCCESS (8.687s)
[101.641214] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[101.644154] [008/133] (916s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[101.736212] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[101.738453] Starting dynamic subtest: pipe-A-eDP-1
[101.761907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.778354] Starting dynamic subtest: pipe-B-eDP-1
[101.801563] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.817623] Starting dynamic subtest: pipe-C-eDP-1
[101.841618] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.856985] Starting dynamic subtest: pipe-D-eDP-1
[101.881723] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.886135] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[104.038473] [009/133] (914s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[104.103564] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[104.165344] [010/133] (913s left) kms_rotation_crc (exhaust-fences)
[104.262445] Starting subtest: exhaust-fences
[104.266646] Subtest exhaust-fences: SKIP (0.000s)
[104.343494] [011/133] (913s left) gem_close (basic)
[104.403382] Starting subtest: basic
[104.405736] Subtest basic: SUCCESS (0.000s)
[104.497595] [012/133] (913s left) kms_chamelium_hpd (common-hpd-after-suspend)
[104.897769] Subtest common-hpd-after-suspend: SKIP (0.000s)
[105.757433] [013/133] (912s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[105.880394] Starting subtest: short-flip-before-cursor-toggle
[106.800632] Subtest short-flip-before-cursor-toggle: SUCCESS (0.920s)
[107.602819] [014/133] (910s left) core_setmaster_vs_auth
[107.793889] [015/133] (910s left) gem_pwrite (basic-random)
[107.854990] Subtest basic-random: SKIP (0.000s)
[107.923021] [016/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[108.012757] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[108.016934] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[108.115870] [017/133] (910s left) kms_pm_rpm (modeset-non-lpsp-stress)
[110.050043] Starting subtest: modeset-non-lpsp-stress
[111.218688] Subtest modeset-non-lpsp-stress: SKIP (1.168s)
[111.608390] [018/133] (906s left) kms_flip (2x-flip-vs-expired-vblank)
[111.707757] Starting subtest: 2x-flip-vs-expired-vblank
[111.719074] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[111.804231] [019/133] (906s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[111.907665] Starting subtest: plane-lut1d-ctm3x4-lut1d
[112.088307] Starting dynamic subtest: pipe-A-plane-0
[112.243979] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[112.253545] Starting dynamic subtest: pipe-A-plane-1
[112.411975] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[112.420135] Starting dynamic subtest: pipe-A-plane-2
[112.576600] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[113.803862] Starting dynamic subtest: pipe-B-plane-0
[113.963179] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[113.971484] Starting dynamic subtest: pipe-B-plane-1
[114.129974] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[114.138277] Starting dynamic subtest: pipe-B-plane-2
[114.296682] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[115.514112] Starting dynamic subtest: pipe-C-plane-0
[115.651428] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[115.660068] Starting dynamic subtest: pipe-C-plane-1
[115.795896] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[115.803840] Starting dynamic subtest: pipe-C-plane-2
[115.929357] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[117.162275] Starting dynamic subtest: pipe-D-plane-0
[117.299610] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[117.308690] Starting dynamic subtest: pipe-D-plane-1
[117.444157] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[117.452673] Starting dynamic subtest: pipe-D-plane-2
[117.588670] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[117.877533] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.969s)
[118.716629] [020/133] (899s left) gem_spin_batch (spin-all-new)
[118.782955] Starting subtest: spin-all-new
[118.796081] Subtest spin-all-new: SUCCESS (0.015s)
[119.945245] [021/133] (898s left) kms_psr (psr-primary-render)
[120.051646] Starting subtest: psr-primary-render
[120.053831] Starting dynamic subtest: eDP-1
[121.822239] Dynamic subtest eDP-1: SUCCESS (1.772s)
[121.824643] Subtest psr-primary-render: SUCCESS (1.772s)
[122.689970] [022/133] (895s left) kms_plane_cursor (overlay)
[122.796940] Starting subtest: overlay
[122.801220] Starting dynamic subtest: pipe-A-eDP-1-size-64
[125.348107] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.552s)
[125.407207] Starting dynamic subtest: pipe-A-eDP-1-size-128
[127.915960] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.516s)
[127.975548] Starting dynamic subtest: pipe-A-eDP-1-size-256
[130.530263] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.564s)
[130.888894] Starting dynamic subtest: pipe-B-eDP-1-size-64
[134.138689] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.257s)
[134.198899] Starting dynamic subtest: pipe-B-eDP-1-size-128
[136.706068] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.516s)
[136.766099] Starting dynamic subtest: pipe-B-eDP-1-size-256
[139.274249] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[139.624101] Starting dynamic subtest: pipe-C-eDP-1-size-64
[142.485321] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.872s)
[142.521616] Starting dynamic subtest: pipe-C-eDP-1-size-128
[144.674845] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.159s)
[144.711797] Starting dynamic subtest: pipe-C-eDP-1-size-256
[146.964111] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.259s)
[147.289465] Starting dynamic subtest: pipe-D-eDP-1-size-64
[150.091230] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.809s)
[150.128075] Starting dynamic subtest: pipe-D-eDP-1-size-128
[152.258361] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.137s)
[152.294827] Starting dynamic subtest: pipe-D-eDP-1-size-256
[154.447639] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[154.765896] Subtest overlay: SUCCESS (31.969s)
[155.614536] [023/133] (863s left) gen9_exec_parse (batch-zero-length)
[155.685272] Subtest batch-zero-length: SKIP (0.000s)
[155.758245] [024/133] (862s left) gem_exec_balancer (parallel-contexts)
[156.020556] Starting subtest: parallel-contexts
[159.389295] Subtest parallel-contexts: SUCCESS (3.368s)
[160.129674] [025/133] (858s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[160.242224] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[160.246354] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.338436] [026/133] (858s left) gem_mmap_gtt (big-bo-tiledy)
[160.400053] Subtest big-bo-tiledY: SKIP (0.000s)
[160.457494] [027/133] (858s left) gem_wait (write-wait)
[160.527171] Starting subtest: write-wait
[160.529528] Starting dynamic subtest: all-engines
[161.678036] Dynamic subtest all-engines: SUCCESS (1.150s)
[161.694062] Starting dynamic subtest: rcs0
[162.740343] Dynamic subtest rcs0: SUCCESS (1.059s)
[162.756188] Starting dynamic subtest: bcs0
[163.799046] Dynamic subtest bcs0: SUCCESS (1.058s)
[163.814427] Starting dynamic subtest: vcs0
[164.852385] Dynamic subtest vcs0: SUCCESS (1.051s)
[164.868312] Starting dynamic subtest: vcs1
[165.907363] Dynamic subtest vcs1: SUCCESS (1.053s)
[165.923725] Starting dynamic subtest: vecs0
[166.961252] Dynamic subtest vecs0: SUCCESS (1.051s)
[166.977333] Starting dynamic subtest: ccs0
[168.017829] Dynamic subtest ccs0: SUCCESS (1.054s)
[168.020652] Subtest write-wait: SUCCESS (7.490s)
[168.219307] [028/133] (850s left) kms_psr (fbc-psr-sprite-plane-move)
[168.311101] Starting subtest: fbc-psr-sprite-plane-move
[168.313421] Starting dynamic subtest: eDP-1
[168.317783] Dynamic subtest eDP-1: SKIP (0.000s)
[168.322204] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[168.383781] [029/133] (850s left) sysfs_timeslice_duration (invalid)
[168.454918] Starting subtest: invalid
[168.457656] Starting dynamic subtest: vecs0
[168.460057] Dynamic subtest vecs0: SUCCESS (0.000s)
[168.469686] Starting dynamic subtest: ccs0
[168.471593] Dynamic subtest ccs0: SUCCESS (0.000s)
[168.479046] Starting dynamic subtest: vcs0
[168.481036] Dynamic subtest vcs0: SUCCESS (0.000s)
[168.488533] Starting dynamic subtest: bcs0
[168.490455] Dynamic subtest bcs0: SUCCESS (0.000s)
[168.501934] Starting dynamic subtest: rcs0
[168.504334] Dynamic subtest rcs0: SUCCESS (0.000s)
[168.512326] Starting dynamic subtest: vcs1
[168.514201] Dynamic subtest vcs1: SUCCESS (0.000s)
[168.516077] Subtest invalid: SUCCESS (0.006s)
[168.559067] [030/133] (850s left) kms_psr (pr-sprite-plane-onoff)
[168.661065] Starting subtest: pr-sprite-plane-onoff
[168.665473] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[168.732917] [031/133] (850s left) kms_cursor_crc (cursor-offscreen-256x256)
[168.990133] Starting subtest: cursor-offscreen-256x256
[168.995112] Starting dynamic subtest: pipe-A-eDP-1
[170.937222] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[170.969451] Starting dynamic subtest: pipe-D-eDP-1
[173.507583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[173.509750] Subtest cursor-offscreen-256x256: SUCCESS (4.516s)
[174.366288] [032/133] (844s left) gem_ctx_persistence (engines-hostile)
[174.419210] Starting subtest: engines-hostile
[174.421459] Starting dynamic subtest: rcs0
[174.454430] Dynamic subtest rcs0: SUCCESS (0.035s)
[174.463970] Starting dynamic subtest: bcs0
[174.561814] Dynamic subtest bcs0: SUCCESS (0.106s)
[174.573145] Starting dynamic subtest: vcs0
[174.652556] Dynamic subtest vcs0: SUCCESS (0.088s)
[174.662683] Starting dynamic subtest: vcs1
[174.733693] Dynamic subtest vcs1: SUCCESS (0.079s)
[174.743693] Starting dynamic subtest: vecs0
[174.847591] Dynamic subtest vecs0: SUCCESS (0.112s)
[174.858134] Starting dynamic subtest: ccs0
[174.954704] Dynamic subtest ccs0: SUCCESS (0.105s)
[174.957260] Subtest engines-hostile: SUCCESS (0.537s)
[175.045946] [033/133] (844s left) gem_exec_reloc (basic-gtt-read-active)
[175.119846] Subtest basic-gtt-read-active: SKIP (0.000s)
[175.192276] [034/133] (843s left) gem_workarounds (basic-read)
[175.260345] Starting subtest: basic-read
[175.270648] Subtest basic-read: SUCCESS (0.010s)
[175.402276] [035/133] (843s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[175.448226] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[175.450073] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[175.544763] [036/133] (843s left) i915_drm_fdinfo (context-close-stress)
[175.584518] Starting subtest: context-close-stress
[186.329881] Subtest context-close-stress: SUCCESS (10.745s)
[186.402532] [037/133] (832s left) gem_ctx_persistence (legacy-engines-hang)
[186.613833] Starting subtest: legacy-engines-hang
[186.616284] Starting dynamic subtest: render
[186.751654] Dynamic subtest render: SUCCESS (0.137s)
[186.765401] Starting dynamic subtest: bsd1
[186.853334] Dynamic subtest bsd1: SUCCESS (0.098s)
[186.864171] Starting dynamic subtest: bsd2
[186.943791] Dynamic subtest bsd2: SUCCESS (0.088s)
[186.956510] Starting dynamic subtest: blt
[187.035494] Dynamic subtest blt: SUCCESS (0.089s)
[187.048475] Starting dynamic subtest: vebox
[187.125639] Dynamic subtest vebox: SUCCESS (0.087s)
[187.128127] Subtest legacy-engines-hang: SUCCESS (0.513s)
[187.209551] [038/133] (832s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[187.301307] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[187.305463] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[187.372421] [039/133] (831s left) syncobj_wait (wait-delayed-signal)
[187.427549] Starting subtest: wait-delayed-signal
[187.529251] Subtest wait-delayed-signal: SUCCESS (0.103s)
[187.610725] [040/133] (831s left) gem_exec_schedule (noreorder)
[187.796054] Starting subtest: noreorder
[187.798692] Starting dynamic subtest: rcs0
[187.864261] Dynamic subtest rcs0: SUCCESS (0.067s)
[187.874151] Starting dynamic subtest: vcs0
[189.906264] Dynamic subtest vcs0: SUCCESS (2.040s)
[189.919650] Starting dynamic subtest: vcs1
[191.890863] Dynamic subtest vcs1: SUCCESS (1.980s)
[191.902920] Starting dynamic subtest: vecs0
[193.874829] Dynamic subtest vecs0: SUCCESS (1.981s)
[193.886627] Starting dynamic subtest: ccs0
[193.942070] Dynamic subtest ccs0: SUCCESS (0.066s)
[193.945060] Subtest noreorder: SUCCESS (6.146s)
[194.132442] [041/133] (825s left) gem_exec_schedule (preempt-self)
[194.196653] Starting subtest: preempt-self
[194.198829] Starting dynamic subtest: rcs0
[194.225573] Dynamic subtest rcs0: SUCCESS (0.034s)
[194.233997] Starting dynamic subtest: bcs0
[194.259793] Dynamic subtest bcs0: SUCCESS (0.033s)
[194.270349] Starting dynamic subtest: vcs0
[194.289536] Dynamic subtest vcs0: SUCCESS (0.030s)
[194.297777] Starting dynamic subtest: vcs1
[194.333795] Dynamic subtest vcs1: SUCCESS (0.043s)
[194.346862] Starting dynamic subtest: vecs0
[194.369329] Dynamic subtest vecs0: SUCCESS (0.034s)
[194.380723] Starting dynamic subtest: ccs0
[194.396897] Dynamic subtest ccs0: SUCCESS (0.027s)
[194.399264] Subtest preempt-self: SUCCESS (0.206s)
[196.036871] [042/133] (823s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[196.141694] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[196.143810] Starting dynamic subtest: pipe-A-default-mode
[197.382724] Dynamic subtest pipe-A-default-mode: SKIP (1.238s)
[197.387123] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.241s)
[197.539518] [043/133] (822s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[197.643740] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[198.502163] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.860s)
[198.675671] [044/133] (820s left) api_intel_bb (delta-check)
[198.736439] Starting subtest: delta-check
[198.739614] Subtest delta-check: SUCCESS (0.006s)
[198.854676] [045/133] (820s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[198.904974] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[198.907127] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[199.020408] [046/133] (820s left) kms_dp_aux_dev (basic)
[199.080482] Starting subtest: basic
[199.303772] Subtest basic: SUCCESS (0.223s)
[199.374927] [047/133] (820s left) kms_psr (fbc-psr2-primary-blt)
[199.462932] Starting subtest: fbc-psr2-primary-blt
[199.465264] Starting dynamic subtest: eDP-1
[199.469628] Dynamic subtest eDP-1: SKIP (0.000s)
[199.473956] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[199.537100] [048/133] (820s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[199.643872] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[199.648095] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.743376] [049/133] (820s left) gem_render_copy (yf-tiled)
[199.811048] Starting subtest: yf-tiled
[199.815306] Subtest yf-tiled: SKIP (0.000s)
[199.990273] [050/133] (819s left) kms_content_protection (dp-mst-type-0)
[200.131365] Starting subtest: dp-mst-type-0
[200.135791] Subtest dp-mst-type-0: SKIP (0.000s)
[200.268634] [051/133] (819s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[200.370024] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[200.374311] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[200.465557] [052/133] (819s left) kms_hdr (bpc-switch-dpms)
[200.567068] Starting subtest: bpc-switch-dpms
[201.675819] Starting dynamic subtest: pipe-A-eDP-1
[206.119149] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.445s)
[206.121316] Subtest bpc-switch-dpms: SUCCESS (5.554s)
[206.221869] [053/133] (813s left) gem_request_retire (retire-vma-not-inactive)
[206.275859] Starting subtest: retire-vma-not-inactive
[206.335852] Subtest retire-vma-not-inactive: SUCCESS (0.056s)
[206.451075] [054/133] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[206.548997] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[206.553242] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[206.646462] [055/133] (813s left) gem_mmap_gtt (basic-write-gtt)
[206.715810] Subtest basic-write-gtt: SKIP (0.000s)
[206.775213] [056/133] (813s left) kms_lease (lease-unleased-connector)
[206.865889] Starting subtest: lease-unleased-connector
[206.868106] Starting dynamic subtest: pipe-A-eDP-1
[206.870282] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[206.879250] Starting dynamic subtest: pipe-B-eDP-1
[206.881417] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.007s)
[206.889883] Starting dynamic subtest: pipe-C-eDP-1
[206.891990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[206.900454] Starting dynamic subtest: pipe-D-eDP-1
[206.902584] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[206.904709] Subtest lease-unleased-connector: SUCCESS (0.031s)
[207.003442] [057/133] (813s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[207.058334] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[207.159810] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.102s)
[207.237155] [058/133] (812s left) kms_flip (blocking-wf_vblank)
[207.326970] Starting subtest: blocking-wf_vblank
[207.329172] Starting dynamic subtest: A-eDP1
[216.231155] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[216.242112] Starting dynamic subtest: B-eDP1
[225.159997] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[225.168601] Starting dynamic subtest: C-eDP1
[234.078968] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[234.087604] Starting dynamic subtest: D-eDP1
[243.005550] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[243.010523] Subtest blocking-wf_vblank: SUCCESS (35.685s)
[244.225727] [059/133] (775s left) gem_exec_store (cachelines)
[244.294301] Starting subtest: cachelines
[244.296271] Starting dynamic subtest: rcs0
[244.372398] Dynamic subtest rcs0: SUCCESS (0.080s)
[244.383671] Starting dynamic subtest: bcs0
[244.433373] Dynamic subtest bcs0: SUCCESS (0.059s)
[244.443561] Starting dynamic subtest: vcs0
[244.499949] Dynamic subtest vcs0: SUCCESS (0.065s)
[244.510269] Starting dynamic subtest: vcs1
[244.562104] Dynamic subtest vcs1: SUCCESS (0.060s)
[244.570874] Starting dynamic subtest: vecs0
[244.615121] Dynamic subtest vecs0: SUCCESS (0.052s)
[244.625720] Starting dynamic subtest: ccs0
[244.679816] Dynamic subtest ccs0: SUCCESS (0.063s)
[244.682668] Subtest cachelines: SUCCESS (0.388s)
[244.865835] [060/133] (775s left) perf (invalid-oa-metric-set-id)
[244.985373] Starting subtest: invalid-oa-metric-set-id
[244.997896] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[245.045630] [061/133] (775s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[245.154362] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[245.158612] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[245.219687] [062/133] (775s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[245.330936] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[245.703540] Starting dynamic subtest: pipe-A-eDP-1
[248.504428] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.800s)
[248.871656] Starting dynamic subtest: pipe-B-eDP-1
[251.631082] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[251.990622] Starting dynamic subtest: pipe-C-eDP-1
[254.760734] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.775s)
[255.146669] Starting dynamic subtest: pipe-D-eDP-1
[257.900792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[257.903120] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.571s)
[259.135478] [063/133] (761s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[259.248499] Starting subtest: 4-tiled-64bpp-rotate-0
[260.929451] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.681s)
[261.085197] [064/133] (759s left) prime_busy (before-wait)
[261.140056] Starting subtest: before-wait
[261.144144] Starting dynamic subtest: rcs0
[261.167051] Dynamic subtest rcs0: SUCCESS (0.024s)
[261.176062] Starting dynamic subtest: bcs0
[261.207877] Dynamic subtest bcs0: SUCCESS (0.040s)
[261.215711] Starting dynamic subtest: vcs0
[261.247686] Dynamic subtest vcs0: SUCCESS (0.039s)
[261.255666] Starting dynamic subtest: vcs1
[261.288585] Dynamic subtest vcs1: SUCCESS (0.040s)
[261.296816] Starting dynamic subtest: vecs0
[261.329841] Dynamic subtest vecs0: SUCCESS (0.041s)
[261.338311] Starting dynamic subtest: ccs0
[261.370621] Dynamic subtest ccs0: SUCCESS (0.040s)
[261.478032] Subtest before-wait: SUCCESS (0.336s)
[261.564462] [065/133] (758s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[261.658316] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[261.660521] Starting dynamic subtest: pipe-A-eDP-1
[267.474448] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.818s)
[267.483929] Starting dynamic subtest: pipe-B-eDP-1
[274.116410] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.638s)
[274.118790] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.459s)
[274.991766] [066/133] (745s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[275.093780] Starting subtest: plane-primary-overlay-mutable-zpos
[278.548707] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.452s)
[279.733024] [067/133] (740s left) kms_draw_crc (draw-method-mmap-wc)
[279.836016] Starting subtest: draw-method-mmap-wc
[279.838202] Starting dynamic subtest: xrgb8888-untiled
[280.090289] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[280.098965] Starting dynamic subtest: rgb565-untiled
[280.324826] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[280.333795] Starting dynamic subtest: xrgb2101010-untiled
[280.546112] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[280.558755] Starting dynamic subtest: xbgr16161616f-untiled
[280.767763] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.219s)
[280.776055] Starting dynamic subtest: xrgb8888-xtiled
[280.889917] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[280.897898] Starting dynamic subtest: rgb565-xtiled
[281.023610] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[281.034247] Starting dynamic subtest: xrgb2101010-xtiled
[281.145534] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[281.154483] Starting dynamic subtest: xbgr16161616f-xtiled
[281.279005] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[281.289364] Starting dynamic subtest: xrgb8888-4tiled
[281.434446] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s)
[281.446165] Starting dynamic subtest: rgb565-4tiled
[281.590349] Dynamic subtest rgb565-4tiled: SUCCESS (0.155s)
[281.600815] Starting dynamic subtest: xrgb2101010-4tiled
[281.734633] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[281.745096] Starting dynamic subtest: xbgr16161616f-4tiled
[281.923569] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.186s)
[281.925672] Subtest draw-method-mmap-wc: SUCCESS (2.090s)
[282.035297] [068/133] (738s left) perf (blocking-parameterized)
[282.132597] Starting subtest: blocking-parameterized
[302.148304] Subtest blocking-parameterized: SUCCESS (20.014s)
[302.195898] [069/133] (718s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[302.307314] Starting subtest: psr-2p-pri-indfb-multidraw
[302.311409] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[302.399607] [070/133] (718s left) prime_vgem (fence-write-hang)
[302.494513] Subtest fence-write-hang: SKIP (0.000s)
[302.603611] [071/133] (718s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[302.719084] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[303.519998] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.804s)
[303.668020] [072/133] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[303.774163] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[303.778189] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[303.865785] [073/133] (716s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[303.972203] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[308.403538] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.434s)
[309.547188] [074/133] (711s left) kms_plane (plane-position-covered)
[309.644223] Starting subtest: plane-position-covered
[310.185681] Starting dynamic subtest: pipe-A-plane-1
[311.451857] Dynamic subtest pipe-A-plane-1: SUCCESS (1.265s)
[311.460988] Starting dynamic subtest: pipe-A-plane-2
[312.752365] Dynamic subtest pipe-A-plane-2: SUCCESS (1.301s)
[312.761494] Starting dynamic subtest: pipe-A-plane-3
[314.021162] Dynamic subtest pipe-A-plane-3: SUCCESS (1.267s)
[314.030635] Starting dynamic subtest: pipe-A-plane-4
[315.328279] Dynamic subtest pipe-A-plane-4: SUCCESS (1.306s)
[315.338578] Starting dynamic subtest: pipe-A-plane-5
[315.353591] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[316.499772] Starting dynamic subtest: pipe-B-plane-1
[317.815924] Dynamic subtest pipe-B-plane-1: SUCCESS (1.325s)
[317.825260] Starting dynamic subtest: pipe-B-plane-2
[319.129054] Dynamic subtest pipe-B-plane-2: SUCCESS (1.310s)
[319.138425] Starting dynamic subtest: pipe-B-plane-3
[320.360443] Dynamic subtest pipe-B-plane-3: SUCCESS (1.233s)
[320.370663] Starting dynamic subtest: pipe-B-plane-4
[321.620602] Dynamic subtest pipe-B-plane-4: SUCCESS (1.258s)
[321.629991] Starting dynamic subtest: pipe-B-plane-5
[321.645303] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[321.647157] Subtest plane-position-covered: SUCCESS (12.001s)
[322.493064] [075/133] (698s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[322.698295] Starting subtest: cursor-rapid-movement-128x128
[322.703321] Starting dynamic subtest: pipe-A-eDP-1
[323.244768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[323.281292] Starting dynamic subtest: pipe-D-eDP-1
[324.488368] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[324.490718] Subtest cursor-rapid-movement-128x128: SUCCESS (1.790s)
[325.347426] [076/133] (695s left) gem_ctx_param (invalid-param-get)
[325.408632] Starting subtest: invalid-param-get
[325.411067] Subtest invalid-param-get: SUCCESS (0.001s)
[325.531461] [077/133] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[325.639231] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[325.643351] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[325.733076] [078/133] (695s left) kms_flip (2x-flip-vs-dpms-on-nop)
[325.830168] Starting subtest: 2x-flip-vs-dpms-on-nop
[325.840161] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[325.935465] [079/133] (695s left) gem_ppgtt (blt-vs-render-ctxn)
[325.989825] Starting subtest: blt-vs-render-ctxN
[358.918198] Subtest blt-vs-render-ctxN: SUCCESS (32.924s)
[359.073891] [080/133] (662s left) perf (oa-exponents)
[359.245194] Starting subtest: oa-exponents
[359.247442] Starting dynamic subtest: 0-rcs0
[361.032103] Dynamic subtest 0-rcs0: SUCCESS (1.788s)
[361.043571] Starting dynamic subtest: 1-vecs0
[362.861553] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[362.864044] Subtest oa-exponents: SUCCESS (3.618s)
[362.920515] [081/133] (658s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[363.028550] Starting subtest: pr-cursor-plane-move-continuous-sf
[363.032969] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[363.098332] [082/133] (658s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[363.196730] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[363.201309] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[363.319586] [083/133] (657s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[363.445346] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[381.062660] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.616s)
[381.955294] [084/133] (639s left) gem_close_race (multigpu-basic-process)
[382.032517] Starting subtest: multigpu-basic-process
[382.036630] Subtest multigpu-basic-process: SKIP (0.000s)
[382.250300] [085/133] (639s left) perf_pmu (pmu-read)
[382.297031] Starting subtest: pmu-read
[382.299290] Subtest pmu-read: SUCCESS (0.003s)
[382.402419] [086/133] (638s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[382.449181] Starting subtest: invalid-multi-wait-unsubmitted
[382.451481] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[382.554897] [087/133] (638s left) gem_exec_fence (syncobj-import)
[382.998088] Starting subtest: syncobj-import
[383.000512] Subtest syncobj-import: SUCCESS (0.005s)
[385.008345] [088/133] (636s left) gem_mmap_offset (mmap-unmap)
[385.068318] Starting subtest: mmap-unmap
[385.070489] Starting dynamic subtest: smem0
[408.977250] Dynamic subtest smem0: SUCCESS (23.908s)
[408.979875] Subtest mmap-unmap: SUCCESS (23.909s)
[409.069617] [089/133] (612s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[409.174452] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[409.178636] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[409.266213] [090/133] (612s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[409.356126] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[417.050283] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.697s)
[417.186277] [091/133] (604s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[417.291768] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[422.242739] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.955s)
[423.394101] [092/133] (598s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[423.499563] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[423.504132] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[423.588662] [093/133] (598s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[423.685958] Starting subtest: bad-pixel-format-y-tiled-ccs
[423.688169] Starting dynamic subtest: pipe-A-eDP-1
[423.711291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.726030] Starting dynamic subtest: pipe-B-eDP-1
[423.748216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[423.757117] Starting dynamic subtest: pipe-C-eDP-1
[423.778863] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[423.787634] Starting dynamic subtest: pipe-D-eDP-1
[423.809802] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[423.813885] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[425.963199] [094/133] (595s left) gem_exec_flush (basic-uc-rw-default)
[426.025579] Starting subtest: basic-uc-rw-default
[431.478642] Subtest basic-uc-rw-default: SUCCESS (5.453s)
[431.667831] [095/133] (590s left) drm_read (short-buffer-block)
[431.810821] Starting subtest: short-buffer-block
[431.812826] Subtest short-buffer-block: SUCCESS (0.000s)
[431.924696] [096/133] (589s left) syncobj_timeline (wait-all-for-submit-snapshot)
[431.975478] Starting subtest: wait-all-for-submit-snapshot
[432.055900] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[432.131827] [097/133] (589s left) kms_getfb (getfb-handle-not-fb)
[432.228059] Starting subtest: getfb-handle-not-fb
[432.230226] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[432.330098] [098/133] (589s left) i915_pm_rps (basic-api)
[432.400920] Starting subtest: basic-api
[432.405455] Subtest basic-api: SKIP (0.001s)
[432.520302] [099/133] (589s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[432.611979] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[432.613768] Starting dynamic subtest: pipe-A-eDP-1
[433.100096] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[433.110776] Starting dynamic subtest: pipe-B-eDP-1
[434.556411] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.450s)
[434.567150] Starting dynamic subtest: pipe-C-eDP-1
[435.957843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[435.969287] Starting dynamic subtest: pipe-D-eDP-1
[437.309923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s)
[437.312040] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.670s)
[438.490339] [100/133] (583s left) sw_sync (sync_random_merge)
[438.534683] Starting subtest: sync_random_merge
[438.576579] Subtest sync_random_merge: SUCCESS (0.044s)
[438.643127] [101/133] (583s left) gem_userptr_blits (map-fixed-invalidate-busy)
[438.712729] Starting subtest: map-fixed-invalidate-busy
[438.717037] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[438.862168] [102/133] (583s left) kms_sequence (queue-idle)
[438.952552] Starting subtest: queue-idle
[438.954537] Starting dynamic subtest: pipe-A-eDP-1
[440.763702] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s)
[440.773884] Starting dynamic subtest: pipe-B-eDP-1
[443.239625] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.474s)
[443.249397] Starting dynamic subtest: pipe-C-eDP-1
[445.665154] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.423s)
[445.675235] Starting dynamic subtest: pipe-D-eDP-1
[448.096860] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s)
[448.099143] Subtest queue-idle: SUCCESS (9.144s)
[448.905421] [103/133] (573s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[448.994273] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[448.996218] Starting dynamic subtest: pipe-A-eDP-1
[449.017123] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s)
[449.027187] Starting dynamic subtest: pipe-B-eDP-1
[449.047867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[449.057206] Starting dynamic subtest: pipe-C-eDP-1
[449.077941] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[449.087665] Starting dynamic subtest: pipe-D-eDP-1
[449.107944] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[449.110218] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.094s)
[451.270316] [104/133] (570s left) kms_getfb (getfb-handle-closed)
[451.369294] Starting subtest: getfb-handle-closed
[451.371732] Subtest getfb-handle-closed: SUCCESS (0.000s)
[451.471158] [105/133] (570s left) gem_caching (read-writes)
[451.528446] Subtest read-writes: SKIP (0.000s)
[451.602056] [106/133] (570s left) gem_mmap_gtt (basic-small-copy-xy)
[451.662875] Subtest basic-small-copy-XY: SKIP (0.000s)
[451.729424] [107/133] (570s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[451.828418] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[456.367899] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.543s)
[457.498968] [108/133] (564s left) kms_joiner (invalid-modeset-force-big-joiner)
[457.602388] Starting subtest: invalid-modeset-force-big-joiner
[457.606493] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[457.671593] [109/133] (564s left) gem_eio (suspend)
[457.908163] Starting subtest: suspend
[470.246477] Subtest suspend: SUCCESS (12.336s)
[470.362257] [110/133] (552s left) gem_fence_thrash (bo-write-verify-threaded-x)
[470.410474] Starting subtest: bo-write-verify-threaded-x
[470.433620] Subtest bo-write-verify-threaded-x: SKIP (0.024s)
[470.514974] [111/133] (551s left) i915_pm_rps (thresholds)
[470.564842] Starting subtest: thresholds
[470.569349] Subtest thresholds: SKIP (0.001s)
[470.666189] [112/133] (551s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[470.760973] Starting subtest: yf-tiled-64bpp-rotate-0
[470.765479] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[470.862793] [113/133] (551s left) kms_vblank (wait-forked-busy)
[470.961850] Starting subtest: wait-forked-busy
[470.964144] Starting dynamic subtest: pipe-A-eDP-1
[472.838526] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[472.853779] Starting dynamic subtest: pipe-D-eDP-1
[475.369043] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s)
[475.371701] Subtest wait-forked-busy: SUCCESS (4.408s)
[476.184440] [114/133] (546s left) gem_exec_balancer (nop)
[476.243448] Starting subtest: nop
[522.872054] Subtest nop: SUCCESS (46.629s)
[523.185186] [115/133] (499s left) i915_pm_freq_api (freq-basic-api)
[523.248937] Starting subtest: freq-basic-api
[523.251294] Starting dynamic subtest: gt0
[523.256868] Dynamic subtest gt0: SUCCESS (0.005s)
[523.267960] Starting dynamic subtest: gt1
[523.270168] Dynamic subtest gt1: SUCCESS (0.003s)
[523.272042] Subtest freq-basic-api: SUCCESS (0.010s)
[523.347673] [116/133] (499s left) gem_basic (multigpu-create-close)
[523.401219] Starting subtest: multigpu-create-close
[523.405361] Subtest multigpu-create-close: SKIP (0.000s)
[523.490987] [117/133] (499s left) kms_psr (psr2-cursor-render)
[523.588793] Starting subtest: psr2-cursor-render
[523.590890] Starting dynamic subtest: eDP-1
[525.281766] Dynamic subtest eDP-1: SUCCESS (1.692s)
[525.284199] Subtest psr2-cursor-render: SUCCESS (1.693s)
[526.082873] [118/133] (496s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[526.175407] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[526.179517] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[526.279966] [119/133] (496s left) kms_chamelium_frames (hdmi-crc-multiple)
[526.659576] Subtest hdmi-crc-multiple: SKIP (0.000s)
[527.493188] [120/133] (495s left) gem_ctx_shared (q-in-order)
[527.558582] Starting subtest: Q-in-order
[527.561068] Starting dynamic subtest: rcs0
[527.659949] Dynamic subtest rcs0: SUCCESS (0.101s)
[527.675846] Starting dynamic subtest: vcs0
[527.742925] Dynamic subtest vcs0: SUCCESS (0.081s)
[527.761590] Starting dynamic subtest: vcs1
[527.829753] Dynamic subtest vcs1: SUCCESS (0.085s)
[527.845704] Starting dynamic subtest: vecs0
[527.906909] Dynamic subtest vecs0: SUCCESS (0.076s)
[527.923442] Starting dynamic subtest: ccs0
[528.003211] Dynamic subtest ccs0: SUCCESS (0.095s)
[528.005851] Subtest Q-in-order: SUCCESS (0.445s)
[529.005257] [121/133] (493s left) drm_buddy (drm_buddy)
[529.050106] Starting subtest: drm_buddy
[529.054399] Subtest drm_buddy: SKIP (0.000s)
[529.105027] [122/133] (493s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[529.199446] Starting subtest: stress-xrgb8888-4tiled
[535.143603] Subtest stress-xrgb8888-4tiled: SUCCESS (5.944s)
[535.204594] [123/133] (487s left) kms_frontbuffer_tracking (psr-suspend)
[535.318257] Starting subtest: psr-suspend
[574.188251] Subtest psr-suspend: SUCCESS (7.979s)
[574.322988] [124/133] (448s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[574.434697] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[574.438780] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[574.543169] [125/133] (448s left) gem_fence_thrash (bo-write-verify-none)
[574.579015] Starting subtest: bo-write-verify-none
[574.593601] Subtest bo-write-verify-none: SKIP (0.013s)
[574.660451] [126/133] (448s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[574.762216] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[574.766287] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[574.867901] [127/133] (448s left) perf (disabled-read-error)
[574.960953] Starting subtest: disabled-read-error
[574.976319] Subtest disabled-read-error: SUCCESS (0.016s)
[575.019369] [128/133] (448s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[575.111656] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[575.116063] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[575.215198] [129/133] (448s left) gem_huc_copy (huc-copy)
[575.273327] Starting subtest: huc-copy
[575.274938] Subtest huc-copy: SUCCESS (0.004s)
[575.385480] [130/133] (447s left) gem_userptr_blits (relocations)
[575.445679] Starting subtest: relocations
[575.449172] Subtest relocations: SKIP (0.000s)
[575.576441] [131/133] (447s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[575.679997] Starting subtest: plane-upscale-20x20-with-pixel-format
[575.681871] Starting dynamic subtest: pipe-A
[576.729311] Dynamic subtest pipe-A: SUCCESS (1.049s)
[576.739034] Starting dynamic subtest: pipe-B
[578.880981] Dynamic subtest pipe-B: SUCCESS (2.149s)
[578.890660] Starting dynamic subtest: pipe-C
[580.081211] Dynamic subtest pipe-C: SUCCESS (1.198s)
[580.091400] Starting dynamic subtest: pipe-D
[581.214639] Dynamic subtest pipe-D: SUCCESS (1.132s)
[581.216825] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.533s)
[582.400439] [132/133] (440s left) gem_render_copy (y-tiled-to-vebox-linear)
[582.457453] Starting subtest: y-tiled-to-vebox-linear
[582.461691] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[582.640448] [133/133] (440s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[582.687235] Starting subtest: single-wait-for-submit-unsubmitted
[582.787890] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[582.867736] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_close
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: core_setmaster_vs_auth
results: parsing output: 14/ for test: gem_pwrite
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_workarounds
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_dp_aux_dev
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_exec_store
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_ppgtt
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_caching
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_fence_thrash
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: i915_pm_freq_api
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: drm_buddy
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_fence_thrash
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_huc_copy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: syncobj_wait
Done.