[60.985059] Initializing watchdogs
[60.985109]   /dev/watchdog0
[60.998775] [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]
[61.003037] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.005199] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.008507] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[61.274299] Starting subtest: cursor-offscreen-256x85
[61.328716] Subtest cursor-offscreen-256x85: SKIP (0.050s)
[61.526501] [002/134] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[61.587993] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[61.653627] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[61.715205] Starting subtest: execute-allforone
[61.730062] Subtest execute-allforone: SUCCESS (0.014s)
[63.042172] [004/134] (958s left) perf_pmu (busy-idle)
[63.078939] Starting subtest: busy-idle
[63.080875] Starting dynamic subtest: rcs0
[63.795367] Dynamic subtest rcs0: SUCCESS (0.720s)
[63.805257] Starting dynamic subtest: bcs0
[64.466206] Dynamic subtest bcs0: SUCCESS (0.673s)
[64.476214] Starting dynamic subtest: vcs0
[65.879402] Dynamic subtest vcs0: SUCCESS (1.416s)
[65.889194] Starting dynamic subtest: vcs1
[67.926957] Dynamic subtest vcs1: SUCCESS (2.053s)
[67.934872] Starting dynamic subtest: vecs0
[69.911449] Dynamic subtest vecs0: SUCCESS (1.988s)
[69.921390] Starting dynamic subtest: ccs0
[70.576753] Dynamic subtest ccs0: SUCCESS (0.667s)
[70.579681] Subtest busy-idle: SUCCESS (7.522s)
[70.695209] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[70.807550] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[71.475360] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.671s)
[71.679356] [006/134] (950s left) api_intel_bb (lot-of-buffers)
[71.742882] Starting subtest: lot-of-buffers
[72.805741] Subtest lot-of-buffers: SUCCESS (1.065s)
[73.039782] [007/134] (948s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[73.100525] Starting subtest: yf-tiled-to-vebox-x-tiled
[73.105444] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[73.291720] [008/134] (948s left) kms_plane (plane-panning-top-left)
[73.396602] Starting subtest: plane-panning-top-left
[73.398440] Starting dynamic subtest: pipe-A
[75.881309] Dynamic subtest pipe-A: SUCCESS (2.485s)
[75.891314] Starting dynamic subtest: pipe-B
[77.776923] Dynamic subtest pipe-B: SUCCESS (1.898s)
[77.780148] Subtest plane-panning-top-left: SUCCESS (4.386s)
[78.607289] [009/134] (943s left) kms_psr (fbc-psr-cursor-plane-onoff)
[78.708723] Starting subtest: fbc-psr-cursor-plane-onoff
[78.711042] Starting dynamic subtest: eDP-1
[78.715268] Dynamic subtest eDP-1: SKIP (0.000s)
[78.719630] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[78.804221] [010/134] (943s left) kms_cursor_crc (cursor-tearing-position-change)
[78.929858] Starting subtest: cursor-tearing-position-change
[78.932179] Starting dynamic subtest: pipe-A-eDP-1
[79.501266] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[79.510344] Starting dynamic subtest: pipe-D-eDP-1
[80.724579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[80.726898] Subtest cursor-tearing-position-change: SUCCESS (1.793s)
[81.581820] [011/134] (940s left) kms_frontbuffer_tracking (basic)
[81.689201] Starting subtest: basic
[85.033410] Subtest basic: SUCCESS (3.347s)
[85.179293] [012/134] (936s left) gem_spin_batch (spin-each)
[85.243463] Starting subtest: spin-each
[88.601155] Subtest spin-each: SUCCESS (3.355s)
[88.970315] [013/134] (932s left) gem_exec_reloc (basic-gtt-cpu)
[89.040493] Subtest basic-gtt-cpu: SKIP (0.000s)
[89.104842] [014/134] (932s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[89.186069] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[89.214267] Starting dynamic subtest: pipe-A-plane-0
[89.503333] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[89.511203] Starting dynamic subtest: pipe-A-plane-3
[89.747911] Dynamic subtest pipe-A-plane-3: SUCCESS (0.244s)
[89.756482] Starting dynamic subtest: pipe-A-plane-5
[89.760726] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[90.844747] Starting dynamic subtest: pipe-B-plane-0
[91.137293] Dynamic subtest pipe-B-plane-0: SUCCESS (0.299s)
[91.146475] Starting dynamic subtest: pipe-B-plane-3
[91.371404] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[91.380139] Starting dynamic subtest: pipe-B-plane-5
[91.384363] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[91.706438] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.518s)
[92.531701] [015/134] (929s left) gem_render_copy (y-tiled-ccs-to-linear)
[92.593736] Starting subtest: y-tiled-ccs-to-linear
[92.598289] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[92.782258] [016/134] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[92.876104] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[92.880192] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[92.993205] [017/134] (929s left) kms_psr (pr-sprite-render)
[93.095597] Starting subtest: pr-sprite-render
[93.099703] Subtest pr-sprite-render: SKIP (0.000s)
[93.173965] [018/134] (928s left) gen9_exec_parse (shadow-peek)
[93.242268] Subtest shadow-peek: SKIP (0.000s)
[93.321988] [019/134] (928s left) perf (invalid-remove-userspace-config)
[93.451579] Starting subtest: invalid-remove-userspace-config
[93.458790] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[93.500621] [020/134] (928s left) gem_ctx_param (invalid-size-set)
[93.557632] Starting subtest: invalid-size-set
[93.560082] Subtest invalid-size-set: SUCCESS (0.001s)
[93.682104] [021/134] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[93.770929] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[93.772888] Starting dynamic subtest: pipe-A-eDP-1
[93.791405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.800731] Starting dynamic subtest: pipe-B-eDP-1
[93.816464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.823399] Starting dynamic subtest: pipe-C-eDP-1
[93.838525] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.845142] Starting dynamic subtest: pipe-D-eDP-1
[93.862378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.865732] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[96.097119] [022/134] (926s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.154470] Starting subtest: invalid-bsd2-flag-on-blt
[96.156682] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.271075] [023/134] (926s left) gem_render_copy (yf-tiled-ccs-to-linear)
[96.336324] Starting subtest: yf-tiled-ccs-to-linear
[96.340617] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[96.531206] [024/134] (925s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[96.588069] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[96.691559] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[96.778139] [025/134] (925s left) gem_exec_fence (invalid-timeline-fence-array)
[97.356084] Starting subtest: invalid-timeline-fence-array
[97.358564] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[98.979691] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[98.982762] [026/134] (923s left) kms_chamelium_edid (dp-edid-read)
[99.359326] Subtest dp-edid-read: SKIP (0.000s)
[100.207162] [027/134] (922s left) gem_exec_params (invalid-bsd1-flag-on-render)
[100.268734] Starting subtest: invalid-bsd1-flag-on-render
[100.270801] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[100.411592] [028/134] (922s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[100.511025] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[101.521538] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[101.666507] [029/134] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[101.771059] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[101.772968] Starting dynamic subtest: pipe-A-eDP-1
[101.791735] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.801793] Starting dynamic subtest: pipe-B-eDP-1
[101.819954] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.827232] Starting dynamic subtest: pipe-C-eDP-1
[101.844707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.851834] Starting dynamic subtest: pipe-D-eDP-1
[101.870240] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.874030] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[104.097284] [030/134] (918s left) gem_eio (kms)
[104.354501] Starting subtest: kms
[124.934111] Subtest kms: SUCCESS (20.576s)
[126.116274] [031/134] (896s left) kms_cursor_legacy (torture-move)
[126.255098] Starting subtest: torture-move
[126.257329] Starting dynamic subtest: pipe-A
[132.596147] Dynamic subtest pipe-A: SUCCESS (6.319s)
[132.611738] Starting dynamic subtest: pipe-B
[139.225965] Dynamic subtest pipe-B: SUCCESS (6.647s)
[139.236416] Starting dynamic subtest: pipe-C
[146.704855] Dynamic subtest pipe-C: SUCCESS (7.477s)
[146.717752] Starting dynamic subtest: pipe-D
[153.211944] Dynamic subtest pipe-D: SUCCESS (6.504s)
[153.223365] Starting dynamic subtest: all-pipes
[160.669798] Dynamic subtest all-pipes: SUCCESS (7.456s)
[160.672586] Subtest torture-move: SUCCESS (34.410s)
[160.836131] [032/134] (861s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[160.936137] Starting subtest: bad-pixel-format-yf-tiled-ccs
[160.938479] Starting dynamic subtest: pipe-A-eDP-1
[160.961769] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.972433] Starting dynamic subtest: pipe-B-eDP-1
[160.994023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.002180] Starting dynamic subtest: pipe-C-eDP-1
[161.023594] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.031626] Starting dynamic subtest: pipe-D-eDP-1
[161.053381] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.057761] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[163.191574] [033/134] (859s left) gem_exec_capture (pi)
[163.243105] Starting subtest: pi
[163.245409] Starting dynamic subtest: rcs0
[167.676058] Dynamic subtest rcs0: SUCCESS (4.432s)
[167.686124] Starting dynamic subtest: bcs0
[171.815783] Dynamic subtest bcs0: SUCCESS (4.139s)
[171.825639] Starting dynamic subtest: vcs0
[176.060071] Dynamic subtest vcs0: SUCCESS (4.243s)
[176.069286] Starting dynamic subtest: vcs1
[180.305845] Dynamic subtest vcs1: SUCCESS (4.245s)
[180.319540] Starting dynamic subtest: vecs0
[184.590263] Dynamic subtest vecs0: SUCCESS (4.283s)
[184.606433] Starting dynamic subtest: ccs0
[188.881094] Dynamic subtest ccs0: SUCCESS (4.290s)
[188.883588] Subtest pi: SUCCESS (25.638s)
[188.976984] [034/134] (833s left) syncobj_timeline (wait-all-snapshot)
[189.089819] Starting subtest: wait-all-snapshot
[189.171528] Subtest wait-all-snapshot: SUCCESS (0.081s)
[189.262058] [035/134] (833s left) kms_async_flips (test-cursor-atomic)
[189.373334] Starting subtest: test-cursor-atomic
[189.377609] Subtest test-cursor-atomic: SKIP (0.000s)
[190.629123] [036/134] (832s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[190.738372] Starting subtest: x-tiled-32bpp-rotate-180
[192.260484] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.522s)
[192.417240] [037/134] (830s left) i915_pm_freq_api (freq-reset)
[192.490092] Starting subtest: freq-reset
[192.492077] Starting dynamic subtest: gt0
[192.688687] Dynamic subtest gt0: SUCCESS (0.196s)
[192.696809] Starting dynamic subtest: gt1
[192.850792] Dynamic subtest gt1: SUCCESS (0.161s)
[192.853738] Subtest freq-reset: SUCCESS (0.359s)
[192.941380] [038/134] (829s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[193.048727] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[197.275437] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.232s)
[198.423964] [039/134] (824s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[198.532320] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[198.534693] Starting dynamic subtest: pipe-A-eDP-1
[198.560679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.572103] Starting dynamic subtest: pipe-B-eDP-1
[198.595600] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.605605] Starting dynamic subtest: pipe-C-eDP-1
[198.628712] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.637206] Starting dynamic subtest: pipe-D-eDP-1
[198.661614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.665979] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[200.688906] [040/134] (822s left) gem_mmap (short-mmap)
[200.748095] Subtest short-mmap: SKIP (0.000s)
[200.818265] [041/134] (822s left) vgem_basic (dmabuf-export)
[200.861830] Starting subtest: dmabuf-export
[200.901692] Subtest dmabuf-export: SUCCESS (0.042s)
[201.056871] [042/134] (822s left) gem_render_copy (y-tiled)
[201.122254] Starting subtest: y-tiled
[201.126798] Subtest y-tiled: SKIP (0.000s)
[201.317475] [043/134] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[201.414454] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[209.110323] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.699s)
[209.258237] [044/134] (813s left) gem_exec_schedule (implicit-write-read)
[209.357906] Starting subtest: implicit-write-read
[209.360309] Starting dynamic subtest: rcs0
[209.457126] Dynamic subtest rcs0: SUCCESS (0.107s)
[209.469019] Starting dynamic subtest: vcs0
[209.531299] Dynamic subtest vcs0: SUCCESS (0.075s)
[209.543469] Starting dynamic subtest: vcs1
[209.611092] Dynamic subtest vcs1: SUCCESS (0.079s)
[209.623050] Starting dynamic subtest: vecs0
[209.693358] Dynamic subtest vecs0: SUCCESS (0.082s)
[209.704939] Starting dynamic subtest: ccs0
[209.782614] Dynamic subtest ccs0: SUCCESS (0.088s)
[209.785458] Subtest implicit-write-read: SUCCESS (0.434s)
[211.036681] [045/134] (812s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[211.146549] Starting subtest: 4-tiled-64bpp-rotate-90
[211.167326] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[211.326993] [046/134] (811s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[211.430070] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[211.432369] Starting dynamic subtest: A-eDP1
[220.377111] Dynamic subtest A-eDP1: SUCCESS (8.946s)
[220.387723] Starting dynamic subtest: B-eDP1
[229.300058] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[229.310791] Starting dynamic subtest: C-eDP1
[238.218318] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[238.229963] Starting dynamic subtest: D-eDP1
[247.135799] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[247.138671] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.708s)
[248.371144] [047/134] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[248.474465] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[248.478587] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.601202] [048/134] (774s left) kms_color_pipeline (plane-lut1d)
[248.691928] Starting subtest: plane-lut1d
[248.705287] Starting dynamic subtest: pipe-A-eDP-1
[249.435083] Dynamic subtest pipe-A-eDP-1: FAIL (0.365s)
[250.132946] Starting dynamic subtest: pipe-B-eDP-1
[250.933328] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[251.458206] Starting dynamic subtest: pipe-C-eDP-1
[252.320178] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[252.792096] Starting dynamic subtest: pipe-D-eDP-1
[253.637781] Dynamic subtest pipe-D-eDP-1: FAIL (0.268s)
[253.640116] Subtest plane-lut1d: FAIL (4.648s)
[254.170656] [049/134] (769s left) i915_pm_rc6_residency (rc6-accuracy)
[254.238131] Starting subtest: rc6-accuracy
[254.240407] Starting dynamic subtest: gt0
[257.409708] Dynamic subtest gt0: SUCCESS (3.169s)
[257.420833] Starting dynamic subtest: gt1
[260.581738] Dynamic subtest gt1: SUCCESS (3.168s)
[260.584252] Subtest rc6-accuracy: SUCCESS (6.342s)
[260.670934] [050/134] (762s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[260.797806] Starting subtest: basic-flip-before-cursor-atomic
[261.712344] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[262.599209] [051/134] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[262.704969] Starting subtest: psr-2p-primscrn-spr-indfb-move
[262.709392] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[262.825044] [052/134] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[262.932505] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[262.936969] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.066942] [053/134] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[268.069628] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[268.074162] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.005s)
[268.943909] [054/134] (754s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[269.011991] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[269.114876] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[269.214522] [055/134] (754s left) gem_mmap_wc (bad-size)
[269.263438] Subtest bad-size: SKIP (0.000s)
[269.337066] [056/134] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[269.449302] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[269.453470] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[269.554797] [057/134] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[269.655627] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[269.659665] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[269.755892] [058/134] (753s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[269.880409] Starting subtest: cursorA-vs-flipB-atomic
[269.885092] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[270.039363] [059/134] (753s left) sysfs_heartbeat_interval (nopreempt)
[270.095990] Starting subtest: nopreempt
[270.098392] Starting dynamic subtest: vecs0
[279.907340] Dynamic subtest vecs0: SUCCESS (9.810s)
[279.918076] Starting dynamic subtest: ccs0
[284.024852] Dynamic subtest ccs0: SUCCESS (4.114s)
[284.036301] Starting dynamic subtest: vcs0
[293.938366] Dynamic subtest vcs0: SUCCESS (9.909s)
[293.952389] Starting dynamic subtest: bcs0
[297.967906] Dynamic subtest bcs0: SUCCESS (4.029s)
[297.978975] Starting dynamic subtest: rcs0
[302.123688] Dynamic subtest rcs0: SUCCESS (4.155s)
[302.138564] Starting dynamic subtest: vcs1
[311.913073] Dynamic subtest vcs1: SUCCESS (9.785s)
[311.915791] Subtest nopreempt: SUCCESS (41.814s)
[312.013882] [060/134] (711s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[312.130062] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[312.134655] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[312.249849] [061/134] (711s left) gem_wait (busy)
[312.320325] Starting subtest: busy
[312.324142] Starting dynamic subtest: all-engines
[313.943835] Dynamic subtest all-engines: SUCCESS (1.625s)
[313.956018] Starting dynamic subtest: rcs0
[314.483852] Dynamic subtest rcs0: SUCCESS (0.539s)
[314.495421] Starting dynamic subtest: bcs0
[315.023849] Dynamic subtest bcs0: SUCCESS (0.539s)
[315.035220] Starting dynamic subtest: vcs0
[316.887085] Dynamic subtest vcs0: SUCCESS (1.861s)
[316.898580] Starting dynamic subtest: vcs1
[318.935402] Dynamic subtest vcs1: SUCCESS (2.046s)
[318.946212] Starting dynamic subtest: vecs0
[320.919514] Dynamic subtest vecs0: SUCCESS (1.982s)
[320.930070] Starting dynamic subtest: ccs0
[321.460943] Dynamic subtest ccs0: SUCCESS (0.541s)
[321.463528] Subtest busy: SUCCESS (9.145s)
[321.688444] [062/134] (702s left) kms_setmode (clone-exclusive-crtc)
[321.763648] Starting subtest: clone-exclusive-crtc
[321.770184] Subtest clone-exclusive-crtc: SKIP (0.000s)
[321.881426] [063/134] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[326.902489] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[326.907178] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[327.779348] [064/134] (696s left) sw_sync (sync_merge_same)
[327.822997] Starting subtest: sync_merge_same
[327.825225] Subtest sync_merge_same: SUCCESS (0.000s)
[327.885202] [065/134] (696s left) kms_hdr (static-toggle)
[327.976695] Starting subtest: static-toggle
[327.983106] Subtest static-toggle: SKIP (0.000s)
[328.060803] [066/134] (696s left) gem_exec_await (wide-contexts)
[328.253519] Starting subtest: wide-contexts
[351.675102] Subtest wide-contexts: SUCCESS (23.420s)
[351.889542] [067/134] (672s left) kms_invalid_mode (uint-max-clock)
[352.040547] Starting subtest: uint-max-clock
[352.042939] Starting dynamic subtest: pipe-A-eDP-1
[352.331037] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[352.340636] Starting dynamic subtest: pipe-B-eDP-1
[352.342876] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[352.351349] Starting dynamic subtest: pipe-C-eDP-1
[352.353525] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[352.362054] Starting dynamic subtest: pipe-D-eDP-1
[352.363956] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[352.365867] Subtest uint-max-clock: SUCCESS (0.297s)
[353.197532] [068/134] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[353.301563] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[357.011924] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.713s)
[358.221913] [069/134] (665s left) kms_pm_rpm (modeset-non-lpsp)
[360.074611] Starting subtest: modeset-non-lpsp
[361.223553] Subtest modeset-non-lpsp: SKIP (1.146s)
[361.609732] [070/134] (662s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[361.714429] Starting subtest: fbc-pr-cursor-mmap-cpu
[361.718729] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[361.796641] [071/134] (662s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[361.894120] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[365.895505] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.004s)
[367.102211] [072/134] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[367.210527] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[367.214806] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[367.350095] [073/134] (657s left) i915_pm_rps (thresholds-idle)
[367.420304] Starting subtest: thresholds-idle
[367.424786] Subtest thresholds-idle: SKIP (0.001s)
[367.535336] [074/134] (656s left) kms_vblank (query-idle-hang)
[367.632264] Starting subtest: query-idle-hang
[367.634494] Starting dynamic subtest: pipe-A-eDP-1
[393.691080] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.055s)
[393.714696] Starting dynamic subtest: pipe-D-eDP-1
[408.660820] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.969s)
[408.663238] Subtest query-idle-hang: SUCCESS (41.029s)
[409.570151] [075/134] (614s left) perf_pmu (most-busy-idle-check-all)
[409.618362] Starting subtest: most-busy-idle-check-all
[409.620362] Starting dynamic subtest: rcs0
[410.903931] Dynamic subtest rcs0: SUCCESS (1.286s)
[410.915247] Starting dynamic subtest: bcs0
[412.888169] Dynamic subtest bcs0: SUCCESS (1.982s)
[412.899477] Starting dynamic subtest: vcs0
[414.937062] Dynamic subtest vcs0: SUCCESS (2.046s)
[414.948745] Starting dynamic subtest: vcs1
[416.920075] Dynamic subtest vcs1: SUCCESS (1.980s)
[416.932126] Starting dynamic subtest: vecs0
[418.903538] Dynamic subtest vecs0: SUCCESS (1.981s)
[418.915764] Starting dynamic subtest: ccs0
[420.888722] Dynamic subtest ccs0: SUCCESS (1.981s)
[420.891809] Subtest most-busy-idle-check-all: SUCCESS (11.272s)
[420.994367] [076/134] (603s left) kms_atomic_interruptible (universal-setplane-cursor)
[421.093863] Starting subtest: universal-setplane-cursor
[421.096091] Starting dynamic subtest: pipe-A-eDP-1
[428.462380] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s)
[428.464767] Subtest universal-setplane-cursor: SUCCESS (7.368s)
[429.334011] [077/134] (595s left) gem_userptr_blits (process-exit-busy)
[429.415881] Starting subtest: process-exit-busy
[429.429388] Subtest process-exit-busy: SUCCESS (0.016s)
[429.614277] [078/134] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[429.709505] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[429.713630] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[429.822600] [079/134] (594s left) gem_lmem_swapping (heavy-verify-multi)
[429.867408] Subtest heavy-verify-multi: SKIP (0.000s)
[429.907280] [080/134] (594s left) gen9_exec_parse (bb-start-cmd)
[429.980925] Subtest bb-start-cmd: SKIP (0.000s)
[430.071850] [081/134] (594s left) fbdev (unaligned-read)
[430.112239] Starting subtest: unaligned-read
[430.128160] Subtest unaligned-read: SUCCESS (0.016s)
[430.200211] [082/134] (594s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[430.592109] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[431.417179] [083/134] (593s left) gem_ppgtt (blt-vs-render-ctx0)
[431.480359] Starting subtest: blt-vs-render-ctx0
[464.309940] Subtest blt-vs-render-ctx0: SUCCESS (32.825s)
[464.458983] [084/134] (560s left) core_setmaster_vs_auth
[464.682262] [085/134] (560s left) prime_busy (hang)
[464.747026] Starting subtest: hang
[464.749716] Starting dynamic subtest: rcs0
[490.417676] Dynamic subtest rcs0: SUCCESS (25.666s)
[490.426131] Starting dynamic subtest: bcs0
[497.578256] Dynamic subtest bcs0: SUCCESS (7.158s)
[497.589119] Starting dynamic subtest: vcs0
[504.545234] Dynamic subtest vcs0: SUCCESS (6.969s)
[504.554302] Starting dynamic subtest: vcs1
[511.590469] Dynamic subtest vcs1: SUCCESS (7.040s)
[511.599341] Starting dynamic subtest: vecs0
[518.559082] Dynamic subtest vecs0: SUCCESS (6.971s)
[518.568349] Starting dynamic subtest: ccs0
[532.402259] Dynamic subtest ccs0: SUCCESS (13.839s)
[532.404706] Subtest hang: SUCCESS (67.651s)
[532.555084] [086/134] (492s left) gem_eio (unwedge-stress)
[532.752028] Starting subtest: unwedge-stress
[532.754303] Starting dynamic subtest: render
[537.215634] Dynamic subtest render: SUCCESS (4.463s)
[537.226978] Starting dynamic subtest: bsd1
[555.336644] Dynamic subtest bsd1: SUCCESS (18.118s)
[555.352324] Starting dynamic subtest: bsd2
[573.320784] Dynamic subtest bsd2: SUCCESS (17.982s)
[573.336674] Starting dynamic subtest: blt
[573.340964] Dynamic subtest blt: SKIP (0.000s)
[573.349550] Starting dynamic subtest: vebox
[591.299957] Dynamic subtest vebox: SUCCESS (17.977s)
[591.302310] Subtest unwedge-stress: SUCCESS (58.544s)
[592.982103] [087/134] (431s left) kms_cursor_crc (cursor-random-256x256)
[593.231981] Starting subtest: cursor-random-256x256
[593.234276] Starting dynamic subtest: pipe-A-eDP-1
[596.610284] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.375s)
[596.639372] Starting dynamic subtest: pipe-D-eDP-1
[600.634194] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[600.636078] Subtest cursor-random-256x256: SUCCESS (7.402s)
[601.499791] [088/134] (423s left) syncobj_timeline (multi-wait-submitted-signaled)
[601.565191] Starting subtest: multi-wait-submitted-signaled
[601.567577] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[601.684573] [089/134] (423s left) kms_dsc (dsc-with-formats)
[601.790989] Starting subtest: dsc-with-formats
[601.829510] Subtest dsc-with-formats: SKIP (0.002s)
[601.876785] [090/134] (423s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[601.970785] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[608.618447] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.649s)
[608.759375] [091/134] (416s left) api_intel_allocator (reopen-fork)
[608.825861] Starting subtest: reopen-fork
[612.282086] Subtest reopen-fork: SUCCESS (3.457s)
[612.379095] [092/134] (412s left) gem_exec_whisper (basic-fds-priority-all)
[612.452896] Starting subtest: basic-fds-priority-all
[636.098346] Subtest basic-fds-priority-all: SUCCESS (23.642s)
[636.295254] [093/134] (388s left) gem_exec_fence (basic-wait-all)
[636.364518] Starting subtest: basic-wait-all
[636.486307] Subtest basic-wait-all: SUCCESS (0.122s)
[638.000389] [094/134] (387s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[638.093104] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[638.095549] Starting dynamic subtest: pipe-A-eDP-1
[638.153743] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[638.164632] Starting dynamic subtest: pipe-B-eDP-1
[638.224304] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[638.234972] Starting dynamic subtest: pipe-C-eDP-1
[638.292038] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[638.302170] Starting dynamic subtest: pipe-D-eDP-1
[638.359583] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[638.363635] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[640.372354] [095/134] (384s left) kms_psr (fbc-psr2-no-drrs)
[640.469646] Starting subtest: fbc-psr2-no-drrs
[640.471822] Starting dynamic subtest: eDP-1
[640.475783] Dynamic subtest eDP-1: SKIP (0.000s)
[640.479697] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[640.566218] [096/134] (384s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[640.653853] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[640.657809] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[640.774274] [097/134] (384s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[640.865371] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[640.869490] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[640.973373] [098/134] (384s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[641.093564] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[644.673772] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.584s)
[645.868698] [099/134] (379s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[645.949533] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[645.951704] Starting dynamic subtest: pipe-A
[645.972715] Dynamic subtest pipe-A: SKIP (0.018s)
[645.982262] Starting dynamic subtest: pipe-B
[646.005524] Dynamic subtest pipe-B: SKIP (0.033s)
[646.015590] Starting dynamic subtest: pipe-C
[646.040488] Dynamic subtest pipe-C: SKIP (0.033s)
[646.049907] Starting dynamic subtest: pipe-D
[646.073396] Dynamic subtest pipe-D: SKIP (0.033s)
[646.077730] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.120s)
[646.187289] [100/134] (379s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[646.281191] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[646.285371] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[646.375251] [101/134] (379s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[646.509485] Starting subtest: flip-vs-cursor-busy-crc-atomic
[647.354474] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.842s)
[648.188429] [102/134] (377s left) core_getstats (basic)
[648.259823] Starting subtest: basic
[648.261641] Subtest basic: SUCCESS (0.000s)
[648.389600] [103/134] (377s left) gem_mmap_gtt (hang-busy)
[648.451115] Subtest hang-busy: SKIP (0.000s)
[648.522032] [104/134] (377s left) kms_flip (flip-vs-expired-vblank-interruptible)
[648.615612] Starting subtest: flip-vs-expired-vblank-interruptible
[648.617769] Starting dynamic subtest: A-eDP1
[657.274566] Dynamic subtest A-eDP1: SUCCESS (8.657s)
[657.285767] Starting dynamic subtest: B-eDP1
[665.913894] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[665.932189] Starting dynamic subtest: C-eDP1
[674.539311] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[674.552527] Starting dynamic subtest: D-eDP1
[683.181077] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[683.183480] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.566s)
[684.377466] [105/134] (341s left) gem_exec_schedule (preempt-queue-contexts)
[684.458556] Subtest preempt-queue-contexts: SKIP (0.000s)
[684.753902] [106/134] (340s left) perf (oa-formats)
[684.866947] Starting subtest: oa-formats
[684.869403] Starting dynamic subtest: 0-rcs0
[684.883318] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[684.894542] Starting dynamic subtest: 1-vecs0
[684.907270] Dynamic subtest 1-vecs0: SUCCESS (0.024s)
[684.909531] Subtest oa-formats: SUCCESS (0.041s)
[684.949272] [107/134] (340s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[685.052227] Starting subtest: fbcpsr-modesetfrombusy
[691.231812] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.183s)
[691.393056] [108/134] (334s left) kms_flip (2x-dpms-vs-vblank-race)
[691.492477] Starting subtest: 2x-dpms-vs-vblank-race
[691.504519] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[691.634300] [109/134] (334s left) gem_exec_params (readonly)
[691.695528] Starting subtest: readonly
[691.700911] Subtest readonly: SUCCESS (0.005s)
[691.836365] [110/134] (334s left) kms_vblank (invalid)
[691.949079] Starting subtest: invalid
[691.950828] Starting dynamic subtest: pipe-A-eDP-1
[692.356851] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[692.359232] Subtest invalid: SUCCESS (0.410s)
[693.245097] [111/134] (332s left) gem_exec_reloc (basic-cpu-read-noreloc)
[693.325651] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[693.411968] [112/134] (332s left) gem_ctx_persistence (engines-hostile)
[693.489560] Starting subtest: engines-hostile
[693.492183] Starting dynamic subtest: rcs0
[693.864858] Dynamic subtest rcs0: SUCCESS (0.373s)
[693.881154] Starting dynamic subtest: bcs0
[693.969818] Dynamic subtest bcs0: SUCCESS (0.104s)
[693.984789] Starting dynamic subtest: vcs0
[694.122647] Dynamic subtest vcs0: SUCCESS (0.152s)
[694.136789] Starting dynamic subtest: vcs1
[694.331017] Dynamic subtest vcs1: SUCCESS (0.207s)
[694.346992] Starting dynamic subtest: vecs0
[694.504705] Dynamic subtest vecs0: SUCCESS (0.171s)
[694.516351] Starting dynamic subtest: ccs0
[694.665974] Dynamic subtest ccs0: SUCCESS (0.160s)
[694.668756] Subtest engines-hostile: SUCCESS (1.178s)
[694.768739] [113/134] (331s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[694.876496] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[694.880574] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[694.987065] [114/134] (331s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[695.088672] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[695.092929] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[695.211543] [115/134] (330s left) gem_caching (writes)
[695.279412] Subtest writes: SKIP (0.000s)
[695.360327] [116/134] (330s left) kms_pm_backlight (fade-with-suspend)
[695.454290] Starting subtest: fade-with-suspend
[711.987952] Starting dynamic subtest: eDP-1
[714.669238] Dynamic subtest eDP-1: SUCCESS (2.761s)
[714.671402] Subtest fade-with-suspend: SUCCESS (4.077s)
[715.519837] [117/134] (310s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[715.630148] Starting subtest: coverage-vs-premult-vs-constant
[715.915071] Starting dynamic subtest: pipe-A-eDP-1
[716.557673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.657s)
[716.567767] Starting dynamic subtest: pipe-D-eDP-1
[717.880576] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s)
[717.882700] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.305s)
[718.712158] [118/134] (307s left) kms_lease (master-vs-lease)
[718.826494] Starting subtest: master-vs-lease
[718.828784] Subtest master-vs-lease: SUCCESS (0.002s)
[718.964513] [119/134] (307s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[719.068475] Starting subtest: psr-rgb565-draw-mmap-wc
[725.913155] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.927s)
[726.061176] [120/134] (300s left) kms_addfb_basic (addfb25-4-tiled)
[726.162642] Starting subtest: addfb25-4-tiled
[726.164467] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[726.287547] [121/134] (300s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[726.387239] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[726.391588] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[726.475292] [122/134] (299s left) kms_plane_multiple (2x-tiling-x)
[726.576468] Starting subtest: 2x-tiling-x
[726.580709] Subtest 2x-tiling-x: SKIP (0.000s)
[726.676052] [123/134] (299s left) kms_psr (psr2-primary-render)
[726.780445] Starting subtest: psr2-primary-render
[726.782690] Starting dynamic subtest: eDP-1
[728.504952] Dynamic subtest eDP-1: SUCCESS (1.733s)
[728.507284] Subtest psr2-primary-render: SUCCESS (1.735s)
[729.380801] [124/134] (297s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[729.445407] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[729.547818] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s)
[729.641034] [125/134] (296s left) gem_exec_balancer (full)
[729.703963] Starting subtest: full
[733.989233] Subtest full: SUCCESS (4.300s)
[734.339545] [126/134] (292s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[734.448372] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[734.452483] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[734.556524] [127/134] (292s left) gem_mmap_wc (write-read)
[734.630054] Subtest write-read: SKIP (0.000s)
[734.694163] [128/134] (291s left) gem_ctx_persistence (process)
[734.765525] Starting subtest: process
[735.002807] Subtest process: SUCCESS (0.240s)
[735.096175] [129/134] (291s left) gem_ctx_param (non-root-set)
[735.156091] Starting subtest: non-root-set
[735.187150] Subtest non-root-set: SUCCESS (0.033s)
[735.292299] [130/134] (291s left) sw_sync (timeline_closed)
[735.328336] Starting subtest: timeline_closed
[735.330215] Subtest timeline_closed: SUCCESS (0.000s)
[735.388340] [131/134] (291s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[735.481523] Starting subtest: primary-4-tiled-reflect-x-180
[742.545370] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.076s)
[743.720128] [132/134] (283s left) gem_exec_parallel (basic)
[743.801359] Starting subtest: basic
[743.803688] Starting dynamic subtest: rcs0
[745.255464] Dynamic subtest rcs0: SUCCESS (1.452s)
[745.267836] Starting dynamic subtest: bcs0
[746.728755] Dynamic subtest bcs0: SUCCESS (1.470s)
[746.741455] Starting dynamic subtest: vcs0
[748.156419] Dynamic subtest vcs0: SUCCESS (1.424s)
[748.169360] Starting dynamic subtest: vcs1
[750.153405] Dynamic subtest vcs1: SUCCESS (1.992s)
[750.175624] Starting dynamic subtest: vecs0
[752.137438] Dynamic subtest vecs0: SUCCESS (1.981s)
[752.150249] Starting dynamic subtest: ccs0
[753.649087] Dynamic subtest ccs0: SUCCESS (1.510s)
[753.651270] Subtest basic: SUCCESS (9.844s)
[753.854320] [133/134] (272s left) kms_content_protection (uevent-hdcp14)
[754.006731] Starting subtest: uevent-hdcp14
[754.011029] Subtest uevent-hdcp14: SKIP (0.000s)
[754.162644] [134/134] (272s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[754.222210] Starting subtest: multi-wait-all-for-submit-available-signaled
[754.224520] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[754.358856] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_ctx_engines
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: i915_pm_freq_api
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: sysfs_heartbeat_interval
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_exec_await
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rps
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: core_setmaster_vs_auth
results: parsing output: 84/ for test: prime_busy
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: core_getstats
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_caching
results: parsing output: 115/ for test: kms_pm_backlight
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: gem_exec_parallel
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: syncobj_timeline
Done.