[59.180422] Initializing watchdogs
[59.180470]   /dev/watchdog0
[59.194792] [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]
[59.199220] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.201288] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.203539] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[59.457603] Starting subtest: cursor-offscreen-256x85
[59.503385] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[59.695965] [002/134] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[59.745958] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[59.813317] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[59.867558] Starting subtest: execute-allforone
[59.881794] Subtest execute-allforone: SUCCESS (0.014s)
[62.009483] [004/134] (957s left) perf_pmu (busy-idle)
[62.042501] Starting subtest: busy-idle
[62.043494] Starting dynamic subtest: rcs0
[62.751855] Dynamic subtest rcs0: SUCCESS (0.709s)
[62.760225] Starting dynamic subtest: bcs0
[63.433379] Dynamic subtest bcs0: SUCCESS (0.681s)
[63.441988] Starting dynamic subtest: vcs0
[64.920095] Dynamic subtest vcs0: SUCCESS (1.484s)
[64.927473] Starting dynamic subtest: vcs1
[66.904277] Dynamic subtest vcs1: SUCCESS (1.982s)
[66.911974] Starting dynamic subtest: vecs0
[68.888872] Dynamic subtest vecs0: SUCCESS (1.983s)
[68.896260] Starting dynamic subtest: ccs0
[69.562854] Dynamic subtest ccs0: SUCCESS (0.675s)
[69.564070] Subtest busy-idle: SUCCESS (7.521s)
[69.665306] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[69.772584] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[70.429232] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.657s)
[70.602340] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[70.656504] Starting subtest: lot-of-buffers
[71.662369] Subtest lot-of-buffers: SUCCESS (1.005s)
[71.987892] [007/134] (947s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[72.051750] Starting subtest: yf-tiled-to-vebox-x-tiled
[72.053588] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[72.234295] [008/134] (947s left) kms_plane (plane-panning-top-left)
[72.321635] Starting subtest: plane-panning-top-left
[72.322617] Starting dynamic subtest: pipe-A
[73.982856] Dynamic subtest pipe-A: SUCCESS (1.659s)
[73.996335] Starting dynamic subtest: pipe-B
[76.243259] Dynamic subtest pipe-B: SUCCESS (2.259s)
[76.244276] Subtest plane-panning-top-left: SUCCESS (3.922s)
[77.075230] [009/134] (942s left) kms_psr (fbc-psr-cursor-plane-onoff)
[77.168260] Starting subtest: fbc-psr-cursor-plane-onoff
[77.169181] Starting dynamic subtest: eDP-1
[77.170923] Dynamic subtest eDP-1: SKIP (0.000s)
[77.172614] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.002s)
[77.248749] [010/134] (942s left) kms_cursor_crc (cursor-tearing-position-change)
[77.353678] Starting subtest: cursor-tearing-position-change
[77.354605] Starting dynamic subtest: pipe-A-eDP-1
[77.905902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[77.912403] Starting dynamic subtest: pipe-D-eDP-1
[79.175801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[79.176786] Subtest cursor-tearing-position-change: SUCCESS (1.822s)
[80.012139] [011/134] (939s left) kms_frontbuffer_tracking (basic)
[80.132165] Starting subtest: basic
[83.357352] Subtest basic: SUCCESS (3.225s)
[83.497910] [012/134] (936s left) gem_spin_batch (spin-each)
[83.552067] Starting subtest: spin-each
[86.815351] Subtest spin-each: SUCCESS (3.262s)
[87.057501] [013/134] (933s left) gem_exec_reloc (basic-gtt-cpu)
[87.118703] Subtest basic-gtt-cpu: SKIP (0.000s)
[87.208961] [014/134] (932s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[87.309080] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[87.337661] Starting dynamic subtest: pipe-A-plane-0
[87.626181] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[87.632798] Starting dynamic subtest: pipe-A-plane-3
[87.881815] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[87.887606] Starting dynamic subtest: pipe-A-plane-5
[87.889207] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[88.991303] Starting dynamic subtest: pipe-B-plane-0
[89.240936] Dynamic subtest pipe-B-plane-0: SUCCESS (0.256s)
[89.252420] Starting dynamic subtest: pipe-B-plane-3
[89.452143] Dynamic subtest pipe-B-plane-3: SUCCESS (0.211s)
[89.459062] Starting dynamic subtest: pipe-B-plane-5
[89.461013] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[89.760203] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.451s)
[90.569195] [015/134] (929s left) gem_render_copy (y-tiled-ccs-to-linear)
[90.624186] Starting subtest: y-tiled-ccs-to-linear
[90.625989] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[90.807257] [016/134] (929s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[90.904603] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[90.906365] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[90.995583] [017/134] (929s left) kms_psr (pr-sprite-render)
[91.087109] Starting subtest: pr-sprite-render
[91.088788] Subtest pr-sprite-render: SKIP (0.000s)
[91.168361] [018/134] (929s left) gen9_exec_parse (shadow-peek)
[91.232667] Subtest shadow-peek: SKIP (0.000s)
[91.288188] [019/134] (928s left) perf (invalid-remove-userspace-config)
[91.404140] Starting subtest: invalid-remove-userspace-config
[91.414123] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[91.441918] [020/134] (928s left) gem_ctx_param (invalid-size-set)
[91.487310] Starting subtest: invalid-size-set
[91.488165] Subtest invalid-size-set: SUCCESS (0.001s)
[91.611662] [021/134] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[91.691311] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[91.692210] Starting dynamic subtest: pipe-A-eDP-1
[91.700929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[91.707628] Starting dynamic subtest: pipe-B-eDP-1
[91.716103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[91.722086] Starting dynamic subtest: pipe-C-eDP-1
[91.730229] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[91.735776] Starting dynamic subtest: pipe-D-eDP-1
[91.744234] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[91.745837] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[93.850062] [022/134] (926s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[93.902823] Starting subtest: invalid-bsd2-flag-on-blt
[93.903797] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[94.000712] [023/134] (926s left) gem_render_copy (yf-tiled-ccs-to-linear)
[94.049859] Starting subtest: yf-tiled-ccs-to-linear
[94.051679] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[94.233269] [024/134] (926s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[94.288551] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[94.396881] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[94.476664] [025/134] (925s left) gem_exec_fence (invalid-timeline-fence-array)
[95.070306] Starting subtest: invalid-timeline-fence-array
[95.075410] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[97.028224] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[97.029880] [026/134] (923s left) kms_chamelium_edid (dp-edid-read)
[97.411691] Subtest dp-edid-read: SKIP (0.000s)
[98.251331] [027/134] (922s left) gem_exec_params (invalid-bsd1-flag-on-render)
[98.312377] Starting subtest: invalid-bsd1-flag-on-render
[98.313447] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[98.433866] [028/134] (922s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[98.534171] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.480252] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.947s)
[99.641886] [029/134] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[99.738125] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[99.738934] Starting dynamic subtest: pipe-A-eDP-1
[99.748648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.755512] Starting dynamic subtest: pipe-B-eDP-1
[99.763593] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.769920] Starting dynamic subtest: pipe-C-eDP-1
[99.777979] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.784175] Starting dynamic subtest: pipe-D-eDP-1
[99.793263] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.794981] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[101.976279] [030/134] (918s left) gem_eio (kms)
[102.232850] Starting subtest: kms
[122.895552] Subtest kms: SUCCESS (20.659s)
[124.072015] [031/134] (896s left) kms_cursor_legacy (torture-move)
[124.188412] Starting subtest: torture-move
[124.189254] Starting dynamic subtest: pipe-A
[129.953261] Dynamic subtest pipe-A: SUCCESS (5.761s)
[129.962668] Starting dynamic subtest: pipe-B
[138.028915] Dynamic subtest pipe-B: SUCCESS (8.077s)
[138.037360] Starting dynamic subtest: pipe-C
[145.278584] Dynamic subtest pipe-C: SUCCESS (7.246s)
[145.290311] Starting dynamic subtest: pipe-D
[152.436744] Dynamic subtest pipe-D: SUCCESS (7.157s)
[152.445808] Starting dynamic subtest: all-pipes
[158.534842] Dynamic subtest all-pipes: SUCCESS (6.099s)
[158.535859] Subtest torture-move: SUCCESS (34.346s)
[158.698517] [032/134] (861s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[158.793477] Starting subtest: bad-pixel-format-yf-tiled-ccs
[158.794451] Starting dynamic subtest: pipe-A-eDP-1
[158.803278] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.810605] Starting dynamic subtest: pipe-B-eDP-1
[158.819195] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.825947] Starting dynamic subtest: pipe-C-eDP-1
[158.833948] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.840255] Starting dynamic subtest: pipe-D-eDP-1
[158.849322] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.851084] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[160.965257] [033/134] (859s left) gem_exec_capture (pi)
[161.023297] Starting subtest: pi
[161.024245] Starting dynamic subtest: rcs0
[165.578269] Dynamic subtest rcs0: SUCCESS (4.556s)
[165.588098] Starting dynamic subtest: bcs0
[169.729870] Dynamic subtest bcs0: SUCCESS (4.151s)
[169.739745] Starting dynamic subtest: vcs0
[174.007375] Dynamic subtest vcs0: SUCCESS (4.276s)
[174.017203] Starting dynamic subtest: vcs1
[178.222692] Dynamic subtest vcs1: SUCCESS (4.215s)
[178.232418] Starting dynamic subtest: vecs0
[182.512922] Dynamic subtest vecs0: SUCCESS (4.290s)
[182.519718] Starting dynamic subtest: ccs0
[186.796560] Dynamic subtest ccs0: SUCCESS (4.283s)
[186.797684] Subtest pi: SUCCESS (25.774s)
[186.880162] [034/134] (833s left) syncobj_timeline (wait-all-snapshot)
[186.969258] Starting subtest: wait-all-snapshot
[187.051470] Subtest wait-all-snapshot: SUCCESS (0.081s)
[187.138771] [035/134] (833s left) kms_async_flips (test-cursor-atomic)
[187.244127] Starting subtest: test-cursor-atomic
[187.245901] Subtest test-cursor-atomic: SKIP (0.000s)
[188.487416] [036/134] (832s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[188.580304] Starting subtest: x-tiled-32bpp-rotate-180
[189.924867] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.345s)
[190.077064] [037/134] (830s left) i915_pm_freq_api (freq-reset)
[190.141471] Starting subtest: freq-reset
[190.142480] Starting dynamic subtest: gt0
[190.338383] Dynamic subtest gt0: SUCCESS (0.196s)
[190.345883] Starting dynamic subtest: gt1
[190.500388] Dynamic subtest gt1: SUCCESS (0.159s)
[190.501745] Subtest freq-reset: SUCCESS (0.357s)
[190.579814] [038/134] (830s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[190.674055] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[194.981389] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.307s)
[196.191253] [039/134] (824s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[196.298626] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[196.299543] Starting dynamic subtest: pipe-A-eDP-1
[196.309333] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[196.316994] Starting dynamic subtest: pipe-B-eDP-1
[196.326577] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[196.333689] Starting dynamic subtest: pipe-C-eDP-1
[196.342818] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[196.349616] Starting dynamic subtest: pipe-D-eDP-1
[196.358969] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[196.360694] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[198.468716] [040/134] (822s left) gem_mmap (short-mmap)
[198.537641] Subtest short-mmap: SKIP (0.000s)
[198.587897] [041/134] (822s left) vgem_basic (dmabuf-export)
[198.627214] Starting subtest: dmabuf-export
[198.654761] Subtest dmabuf-export: SUCCESS (0.028s)
[198.776859] [042/134] (822s left) gem_render_copy (y-tiled)
[198.833066] Starting subtest: y-tiled
[198.835075] Subtest y-tiled: SKIP (0.000s)
[199.018565] [043/134] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[199.113696] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[206.753832] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.641s)
[206.885320] [044/134] (814s left) gem_exec_schedule (implicit-write-read)
[206.962103] Starting subtest: implicit-write-read
[206.963075] Starting dynamic subtest: rcs0
[207.069256] Dynamic subtest rcs0: SUCCESS (0.107s)
[207.078492] Starting dynamic subtest: vcs0
[207.145809] Dynamic subtest vcs0: SUCCESS (0.076s)
[207.156366] Starting dynamic subtest: vcs1
[207.234610] Dynamic subtest vcs1: SUCCESS (0.088s)
[207.244987] Starting dynamic subtest: vecs0
[207.309984] Dynamic subtest vecs0: SUCCESS (0.075s)
[207.319673] Starting dynamic subtest: ccs0
[207.398973] Dynamic subtest ccs0: SUCCESS (0.088s)
[207.400428] Subtest implicit-write-read: SUCCESS (0.438s)
[209.045550] [045/134] (812s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[209.132632] Starting subtest: 4-tiled-64bpp-rotate-90
[209.152489] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[209.283781] [046/134] (811s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[209.379229] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[209.381360] Starting dynamic subtest: A-eDP1
[218.246912] Dynamic subtest A-eDP1: SUCCESS (8.865s)
[218.256980] Starting dynamic subtest: B-eDP1
[227.179070] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[227.188667] Starting dynamic subtest: C-eDP1
[236.094369] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[236.105440] Starting dynamic subtest: D-eDP1
[244.937442] Dynamic subtest D-eDP1: SUCCESS (8.842s)
[244.939870] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.561s)
[246.171237] [047/134] (774s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[246.271133] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[246.272920] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.369325] [048/134] (774s left) kms_color_pipeline (plane-lut1d)
[246.455844] Starting subtest: plane-lut1d
[246.471218] Starting dynamic subtest: pipe-A-eDP-1
[246.938533] Dynamic subtest pipe-A-eDP-1: FAIL (0.330s)
[247.844718] Starting dynamic subtest: pipe-B-eDP-1
[248.336528] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[249.173253] Starting dynamic subtest: pipe-C-eDP-1
[249.643694] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[250.496775] Starting dynamic subtest: pipe-D-eDP-1
[250.941575] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[251.030430] Subtest plane-lut1d: FAIL (4.574s)
[251.890000] [049/134] (769s left) i915_pm_rc6_residency (rc6-accuracy)
[251.952479] Starting subtest: rc6-accuracy
[251.953363] Starting dynamic subtest: gt0
[255.125525] Dynamic subtest gt0: SUCCESS (3.169s)
[255.135236] Starting dynamic subtest: gt1
[258.297742] Dynamic subtest gt1: SUCCESS (3.169s)
[258.298988] Subtest rc6-accuracy: SUCCESS (6.343s)
[258.381847] [050/134] (762s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[258.506183] Starting subtest: basic-flip-before-cursor-atomic
[259.418865] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.912s)
[260.307627] [051/134] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[260.418394] Starting subtest: psr-2p-primscrn-spr-indfb-move
[260.420080] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[260.539482] [052/134] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[260.629451] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[260.630992] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[260.737260] [053/134] (760s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[265.691452] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[265.696800] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[266.555785] [054/134] (754s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[266.628777] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[266.732426] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[266.812830] [055/134] (754s left) gem_mmap_wc (bad-size)
[266.872140] Subtest bad-size: SKIP (0.000s)
[266.946375] [056/134] (754s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[267.037460] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[267.039237] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[267.161355] [057/134] (754s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[267.257125] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[267.258795] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[267.375820] [058/134] (754s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[267.497430] Starting subtest: cursorA-vs-flipB-atomic
[267.499389] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[267.647452] [059/134] (753s left) sysfs_heartbeat_interval (nopreempt)
[267.717333] Starting subtest: nopreempt
[267.718303] Starting dynamic subtest: vecs0
[276.915164] Dynamic subtest vecs0: SUCCESS (9.196s)
[276.931378] Starting dynamic subtest: ccs0
[281.030234] Dynamic subtest ccs0: SUCCESS (4.112s)
[281.040226] Starting dynamic subtest: vcs0
[290.917928] Dynamic subtest vcs0: SUCCESS (9.885s)
[290.929436] Starting dynamic subtest: bcs0
[296.658953] Dynamic subtest bcs0: SUCCESS (5.735s)
[296.668698] Starting dynamic subtest: rcs0
[300.743598] Dynamic subtest rcs0: SUCCESS (4.085s)
[300.754245] Starting dynamic subtest: vcs1
[308.905416] Dynamic subtest vcs1: SUCCESS (8.156s)
[308.906690] Subtest nopreempt: SUCCESS (41.183s)
[308.989265] [060/134] (712s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[309.085198] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[309.086912] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[309.200959] [061/134] (712s left) gem_wait (busy)
[309.269901] Starting subtest: busy
[309.270999] Starting dynamic subtest: all-engines
[310.936626] Dynamic subtest all-engines: SUCCESS (1.663s)
[310.946590] Starting dynamic subtest: rcs0
[311.477055] Dynamic subtest rcs0: SUCCESS (0.540s)
[311.487446] Starting dynamic subtest: bcs0
[312.016318] Dynamic subtest bcs0: SUCCESS (0.538s)
[312.025346] Starting dynamic subtest: vcs0
[313.943990] Dynamic subtest vcs0: SUCCESS (1.924s)
[313.954435] Starting dynamic subtest: vcs1
[315.928391] Dynamic subtest vcs1: SUCCESS (1.982s)
[315.944944] Starting dynamic subtest: vecs0
[317.847805] Dynamic subtest vecs0: SUCCESS (1.916s)
[317.869048] Starting dynamic subtest: ccs0
[318.389309] Dynamic subtest ccs0: SUCCESS (0.541s)
[318.390575] Subtest busy: SUCCESS (9.119s)
[318.608986] [062/134] (703s left) kms_setmode (clone-exclusive-crtc)
[318.660658] Starting subtest: clone-exclusive-crtc
[318.663816] Subtest clone-exclusive-crtc: SKIP (0.000s)
[318.781336] [063/134] (702s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[323.725864] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[323.728930] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[324.566311] [064/134] (697s left) sw_sync (sync_merge_same)
[324.598711] Starting subtest: sync_merge_same
[324.599638] Subtest sync_merge_same: SUCCESS (0.000s)
[324.668461] [065/134] (697s left) kms_hdr (static-toggle)
[324.760306] Starting subtest: static-toggle
[324.762950] Subtest static-toggle: SKIP (0.000s)
[324.837479] [066/134] (696s left) gem_exec_await (wide-contexts)
[325.037390] Starting subtest: wide-contexts
[348.675181] Subtest wide-contexts: SUCCESS (23.638s)
[348.867177] [067/134] (672s left) kms_invalid_mode (uint-max-clock)
[348.981469] Starting subtest: uint-max-clock
[348.982384] Starting dynamic subtest: pipe-A-eDP-1
[349.272568] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.291s)
[349.279903] Starting dynamic subtest: pipe-B-eDP-1
[349.281077] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[349.287726] Starting dynamic subtest: pipe-C-eDP-1
[349.292819] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[349.299405] Starting dynamic subtest: pipe-D-eDP-1
[349.300260] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[349.301070] Subtest uint-max-clock: SUCCESS (0.297s)
[350.090567] [068/134] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[350.176935] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[353.877887] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.701s)
[355.003214] [069/134] (666s left) kms_pm_rpm (modeset-non-lpsp)
[357.039310] Starting subtest: modeset-non-lpsp
[358.184260] Subtest modeset-non-lpsp: SKIP (1.146s)
[358.575843] [070/134] (663s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[358.669325] Starting subtest: fbc-pr-cursor-mmap-cpu
[358.671039] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[358.747644] [071/134] (663s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[358.845309] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[362.861885] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.016s)
[364.083703] [072/134] (657s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[364.181254] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[364.182943] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[364.293493] [073/134] (657s left) i915_pm_rps (thresholds-idle)
[364.349844] Starting subtest: thresholds-idle
[364.351880] Subtest thresholds-idle: SKIP (0.000s)
[364.461758] [074/134] (657s left) kms_vblank (query-idle-hang)
[364.546273] Starting subtest: query-idle-hang
[364.547139] Starting dynamic subtest: pipe-A-eDP-1
[390.734297] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.186s)
[390.744027] Starting dynamic subtest: pipe-D-eDP-1
[415.652730] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.913s)
[415.653681] Subtest query-idle-hang: SUCCESS (51.105s)
[416.528985] [075/134] (605s left) perf_pmu (most-busy-idle-check-all)
[416.574414] Starting subtest: most-busy-idle-check-all
[416.575291] Starting dynamic subtest: rcs0
[417.880843] Dynamic subtest rcs0: SUCCESS (1.303s)
[417.890874] Starting dynamic subtest: bcs0
[419.929108] Dynamic subtest bcs0: SUCCESS (2.045s)
[419.938833] Starting dynamic subtest: vcs0
[421.913476] Dynamic subtest vcs0: SUCCESS (1.981s)
[421.923223] Starting dynamic subtest: vcs1
[423.896844] Dynamic subtest vcs1: SUCCESS (1.981s)
[423.907153] Starting dynamic subtest: vecs0
[425.880768] Dynamic subtest vecs0: SUCCESS (1.981s)
[425.891427] Starting dynamic subtest: ccs0
[427.865972] Dynamic subtest ccs0: SUCCESS (1.982s)
[427.867655] Subtest most-busy-idle-check-all: SUCCESS (11.290s)
[427.971424] [076/134] (594s left) kms_atomic_interruptible (universal-setplane-cursor)
[428.070576] Starting subtest: universal-setplane-cursor
[428.071575] Starting dynamic subtest: pipe-A-eDP-1
[435.439778] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.367s)
[435.440721] Subtest universal-setplane-cursor: SUCCESS (7.368s)
[436.291405] [077/134] (585s left) gem_userptr_blits (process-exit-busy)
[436.353218] Starting subtest: process-exit-busy
[436.371053] Subtest process-exit-busy: SUCCESS (0.019s)
[436.528103] [078/134] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[436.627867] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[436.629782] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[436.754490] [079/134] (585s left) gem_lmem_swapping (heavy-verify-multi)
[436.791963] Subtest heavy-verify-multi: SKIP (0.000s)
[436.828791] [080/134] (585s left) gen9_exec_parse (bb-start-cmd)
[436.884050] Subtest bb-start-cmd: SKIP (0.000s)
[436.961732] [081/134] (585s left) fbdev (unaligned-read)
[437.002471] Starting subtest: unaligned-read
[437.018873] Subtest unaligned-read: SUCCESS (0.016s)
[437.076716] [082/134] (585s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[437.464463] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[438.297475] [083/134] (584s left) gem_ppgtt (blt-vs-render-ctx0)
[438.346160] Starting subtest: blt-vs-render-ctx0
[471.228217] Subtest blt-vs-render-ctx0: SUCCESS (32.878s)
[471.371831] [084/134] (550s left) core_setmaster_vs_auth
[471.597850] [085/134] (550s left) prime_busy (hang)
[471.657038] Starting subtest: hang
[471.659189] Starting dynamic subtest: rcs0
[497.461826] Dynamic subtest rcs0: SUCCESS (25.801s)
[497.471409] Starting dynamic subtest: bcs0
[504.551732] Dynamic subtest bcs0: SUCCESS (7.088s)
[504.560490] Starting dynamic subtest: vcs0
[511.589921] Dynamic subtest vcs0: SUCCESS (7.040s)
[511.597336] Starting dynamic subtest: vcs1
[518.572703] Dynamic subtest vcs1: SUCCESS (6.981s)
[518.579812] Starting dynamic subtest: vecs0
[525.538900] Dynamic subtest vecs0: SUCCESS (6.966s)
[525.546549] Starting dynamic subtest: ccs0
[539.452975] Dynamic subtest ccs0: SUCCESS (13.911s)
[539.454261] Subtest hang: SUCCESS (67.794s)
[539.623372] [086/134] (482s left) gem_eio (unwedge-stress)
[539.809933] Starting subtest: unwedge-stress
[539.810830] Starting dynamic subtest: render
[544.295711] Dynamic subtest render: SUCCESS (4.485s)
[544.305476] Starting dynamic subtest: bsd1
[562.318333] Dynamic subtest bsd1: SUCCESS (18.020s)
[562.336448] Starting dynamic subtest: bsd2
[580.346798] Dynamic subtest bsd2: SUCCESS (18.027s)
[580.357389] Starting dynamic subtest: blt
[580.364220] Dynamic subtest blt: SKIP (0.000s)
[580.371689] Starting dynamic subtest: vebox
[598.342562] Dynamic subtest vebox: SUCCESS (17.990s)
[598.343935] Subtest unwedge-stress: SUCCESS (58.529s)
[599.938793] [087/134] (422s left) kms_cursor_crc (cursor-random-256x256)
[600.183823] Starting subtest: cursor-random-256x256
[600.187260] Starting dynamic subtest: pipe-A-eDP-1
[603.508755] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.320s)
[603.535340] Starting dynamic subtest: pipe-D-eDP-1
[607.503251] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.974s)
[607.504175] Subtest cursor-random-256x256: SUCCESS (7.319s)
[608.384770] [088/134] (414s left) syncobj_timeline (multi-wait-submitted-signaled)
[608.448014] Starting subtest: multi-wait-submitted-signaled
[608.449061] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[608.576956] [089/134] (413s left) kms_dsc (dsc-with-formats)
[608.673259] Starting subtest: dsc-with-formats
[608.687769] Subtest dsc-with-formats: SKIP (0.001s)
[608.753845] [090/134] (413s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[608.851883] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[615.464303] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.610s)
[615.582867] [091/134] (406s left) api_intel_allocator (reopen-fork)
[615.643141] Starting subtest: reopen-fork
[619.267210] Subtest reopen-fork: SUCCESS (3.623s)
[619.347282] [092/134] (403s left) gem_exec_whisper (basic-fds-priority-all)
[619.418868] Starting subtest: basic-fds-priority-all
[643.047365] Subtest basic-fds-priority-all: SUCCESS (23.625s)
[643.224973] [093/134] (379s left) gem_exec_fence (basic-wait-all)
[643.285492] Starting subtest: basic-wait-all
[643.419411] Subtest basic-wait-all: SUCCESS (0.133s)
[645.005496] [094/134] (377s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[645.083535] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[645.084431] Starting dynamic subtest: pipe-A-eDP-1
[645.106278] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[645.115040] Starting dynamic subtest: pipe-B-eDP-1
[645.135802] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[645.143346] Starting dynamic subtest: pipe-C-eDP-1
[645.164325] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[645.171732] Starting dynamic subtest: pipe-D-eDP-1
[645.192374] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[645.193945] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[647.261331] [095/134] (375s left) kms_psr (fbc-psr2-no-drrs)
[647.349504] Starting subtest: fbc-psr2-no-drrs
[647.350397] Starting dynamic subtest: eDP-1
[647.352131] Dynamic subtest eDP-1: SKIP (0.000s)
[647.353807] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[647.428175] [096/134] (375s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[647.522745] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[647.524459] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[647.634851] [097/134] (375s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[647.719715] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[647.721380] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[647.841102] [098/134] (374s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[647.937942] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[651.588447] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.650s)
[652.767182] [099/134] (370s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[652.863029] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[652.863892] Starting dynamic subtest: pipe-A
[652.880668] Dynamic subtest pipe-A: SKIP (0.016s)
[652.888351] Starting dynamic subtest: pipe-B
[652.912681] Dynamic subtest pipe-B: SKIP (0.030s)
[652.920458] Starting dynamic subtest: pipe-C
[652.942214] Dynamic subtest pipe-C: SKIP (0.030s)
[652.950011] Starting dynamic subtest: pipe-D
[652.972268] Dynamic subtest pipe-D: SKIP (0.029s)
[652.974060] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.107s)
[653.105294] [100/134] (369s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[653.188384] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[653.190083] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[653.280890] [101/134] (369s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[653.402717] Starting subtest: flip-vs-cursor-busy-crc-atomic
[654.211712] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.809s)
[655.081765] [102/134] (367s left) core_getstats (basic)
[655.134019] Starting subtest: basic
[655.135376] Subtest basic: SUCCESS (0.000s)
[655.243283] [103/134] (367s left) gem_mmap_gtt (hang-busy)
[655.301346] Subtest hang-busy: SKIP (0.000s)
[655.363532] [104/134] (367s left) kms_flip (flip-vs-expired-vblank-interruptible)
[655.457895] Starting subtest: flip-vs-expired-vblank-interruptible
[655.460183] Starting dynamic subtest: A-eDP1
[664.165949] Dynamic subtest A-eDP1: SUCCESS (8.705s)
[664.176529] Starting dynamic subtest: B-eDP1
[672.785280] Dynamic subtest B-eDP1: SUCCESS (8.617s)
[672.795930] Starting dynamic subtest: C-eDP1
[681.405390] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[681.414466] Starting dynamic subtest: D-eDP1
[690.037645] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[690.041749] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.583s)
[691.212749] [105/134] (331s left) gem_exec_schedule (preempt-queue-contexts)
[691.271715] Subtest preempt-queue-contexts: SKIP (0.000s)
[691.571803] [106/134] (331s left) perf (oa-formats)
[691.680256] Starting subtest: oa-formats
[691.681228] Starting dynamic subtest: 0-rcs0
[691.694852] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[691.703788] Starting dynamic subtest: 1-vecs0
[691.716772] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[691.718061] Subtest oa-formats: SUCCESS (0.039s)
[691.756234] [107/134] (331s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[691.844358] Starting subtest: fbcpsr-modesetfrombusy
[698.086811] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.246s)
[698.244471] [108/134] (324s left) kms_flip (2x-dpms-vs-vblank-race)
[698.345475] Starting subtest: 2x-dpms-vs-vblank-race
[698.356984] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[698.439361] [109/134] (324s left) gem_exec_params (readonly)
[698.498800] Starting subtest: readonly
[698.501451] Subtest readonly: SUCCESS (0.003s)
[698.631203] [110/134] (324s left) kms_vblank (invalid)
[698.723167] Starting subtest: invalid
[698.724063] Starting dynamic subtest: pipe-A-eDP-1
[699.119052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[699.119945] Subtest invalid: SUCCESS (0.396s)
[700.005015] [111/134] (323s left) gem_exec_reloc (basic-cpu-read-noreloc)
[700.062445] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[700.124725] [112/134] (323s left) gem_ctx_persistence (engines-hostile)
[700.168145] Starting subtest: engines-hostile
[700.168961] Starting dynamic subtest: rcs0
[700.281937] Dynamic subtest rcs0: SUCCESS (0.113s)
[700.293579] Starting dynamic subtest: bcs0
[700.388489] Dynamic subtest bcs0: SUCCESS (0.105s)
[700.405588] Starting dynamic subtest: vcs0
[700.518913] Dynamic subtest vcs0: SUCCESS (0.127s)
[700.530598] Starting dynamic subtest: vcs1
[700.639873] Dynamic subtest vcs1: SUCCESS (0.118s)
[700.651550] Starting dynamic subtest: vecs0
[700.749833] Dynamic subtest vecs0: SUCCESS (0.107s)
[700.760832] Starting dynamic subtest: ccs0
[700.858612] Dynamic subtest ccs0: SUCCESS (0.106s)
[700.862216] Subtest engines-hostile: SUCCESS (0.692s)
[700.942954] [113/134] (322s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[701.027612] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[701.029339] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[701.159955] [114/134] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[701.252517] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[701.254081] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[701.380641] [115/134] (321s left) gem_caching (writes)
[701.439748] Subtest writes: SKIP (0.000s)
[701.504429] [116/134] (321s left) kms_pm_backlight (fade-with-suspend)
[701.583298] Starting subtest: fade-with-suspend
[717.895859] Starting dynamic subtest: eDP-1
[720.572438] Dynamic subtest eDP-1: SUCCESS (2.677s)
[720.573393] Subtest fade-with-suspend: SUCCESS (5.156s)
[725.432884] [117/134] (301s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[725.533855] Starting subtest: coverage-vs-premult-vs-constant
[725.830293] Starting dynamic subtest: pipe-A-eDP-1
[726.420261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.589s)
[726.429864] Starting dynamic subtest: pipe-D-eDP-1
[727.747972] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[727.748914] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.213s)
[728.577557] [118/134] (298s left) kms_lease (master-vs-lease)
[728.670908] Starting subtest: master-vs-lease
[728.672932] Subtest master-vs-lease: SUCCESS (0.002s)
[728.805009] [119/134] (298s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[728.901412] Starting subtest: psr-rgb565-draw-mmap-wc
[735.572329] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.666s)
[735.680252] [120/134] (291s left) kms_addfb_basic (addfb25-4-tiled)
[735.781962] Starting subtest: addfb25-4-tiled
[735.782815] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[735.909292] [121/134] (291s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[736.011962] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[736.013693] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[736.087692] [122/134] (291s left) kms_plane_multiple (2x-tiling-x)
[736.182966] Starting subtest: 2x-tiling-x
[736.184653] Subtest 2x-tiling-x: SKIP (0.000s)
[736.268931] [123/134] (291s left) kms_psr (psr2-primary-render)
[736.359418] Starting subtest: psr2-primary-render
[736.360559] Starting dynamic subtest: eDP-1
[738.076415] Dynamic subtest eDP-1: SUCCESS (1.716s)
[738.077349] Subtest psr2-primary-render: SUCCESS (1.717s)
[738.959167] [124/134] (288s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[739.019934] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[739.125921] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[739.207898] [125/134] (288s left) gem_exec_balancer (full)
[739.263865] Starting subtest: full
[743.662635] Subtest full: SUCCESS (4.397s)
[744.001422] [126/134] (283s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[744.116882] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[744.118613] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[744.234283] [127/134] (283s left) gem_mmap_wc (write-read)
[744.291181] Subtest write-read: SKIP (0.000s)
[744.348517] [128/134] (283s left) gem_ctx_persistence (process)
[744.410306] Starting subtest: process
[744.620864] Subtest process: SUCCESS (0.212s)
[744.705628] [129/134] (283s left) gem_ctx_param (non-root-set)
[744.770543] Starting subtest: non-root-set
[744.803088] Subtest non-root-set: SUCCESS (0.033s)
[744.908299] [130/134] (282s left) sw_sync (timeline_closed)
[744.940131] Starting subtest: timeline_closed
[744.941022] Subtest timeline_closed: SUCCESS (0.000s)
[745.002190] [131/134] (282s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[745.084952] Starting subtest: primary-4-tiled-reflect-x-180
[752.179218] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.093s)
[753.404546] [132/134] (274s left) gem_exec_parallel (basic)
[753.455337] Starting subtest: basic
[753.456286] Starting dynamic subtest: rcs0
[754.901536] Dynamic subtest rcs0: SUCCESS (1.445s)
[754.913860] Starting dynamic subtest: bcs0
[756.371218] Dynamic subtest bcs0: SUCCESS (1.467s)
[756.382981] Starting dynamic subtest: vcs0
[757.773321] Dynamic subtest vcs0: SUCCESS (1.401s)
[757.783468] Starting dynamic subtest: vcs1
[759.713871] Dynamic subtest vcs1: SUCCESS (1.935s)
[759.725081] Starting dynamic subtest: vecs0
[761.761198] Dynamic subtest vecs0: SUCCESS (2.044s)
[761.772319] Starting dynamic subtest: ccs0
[763.237090] Dynamic subtest ccs0: SUCCESS (1.475s)
[763.239635] Subtest basic: SUCCESS (9.782s)
[763.431597] [133/134] (264s left) kms_content_protection (uevent-hdcp14)
[763.582166] Starting subtest: uevent-hdcp14
[763.584039] Subtest uevent-hdcp14: SKIP (0.000s)
[763.745987] [134/134] (264s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[763.802659] Starting subtest: multi-wait-all-for-submit-available-signaled
[763.803487] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[763.921325] 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.