[62.630983] Initializing watchdogs
[62.631049]   /dev/watchdog0
[62.645430] [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]
[62.649819] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.651989] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.655127] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[62.942823] Starting subtest: cursor-offscreen-256x85
[62.995569] Subtest cursor-offscreen-256x85: SKIP (0.048s)
[63.210030] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[63.264642] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[63.330116] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[63.399602] Starting subtest: execute-allforone
[63.413415] Subtest execute-allforone: SUCCESS (0.014s)
[64.980384] [004/134] (958s left) perf_pmu (busy-idle)
[65.017645] Starting subtest: busy-idle
[65.019867] Starting dynamic subtest: rcs0
[65.725066] Dynamic subtest rcs0: SUCCESS (0.709s)
[65.733819] Starting dynamic subtest: bcs0
[66.392053] Dynamic subtest bcs0: SUCCESS (0.667s)
[66.400898] Starting dynamic subtest: vcs0
[67.923778] Dynamic subtest vcs0: SUCCESS (1.531s)
[67.933869] Starting dynamic subtest: vcs1
[69.908732] Dynamic subtest vcs1: SUCCESS (1.985s)
[69.919767] Starting dynamic subtest: vecs0
[71.894068] Dynamic subtest vecs0: SUCCESS (1.986s)
[71.904052] Starting dynamic subtest: ccs0
[72.571321] Dynamic subtest ccs0: SUCCESS (0.679s)
[72.573905] Subtest busy-idle: SUCCESS (7.562s)
[72.700407] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[72.805244] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[73.461952] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[73.674129] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[73.738886] Starting subtest: lot-of-buffers
[74.751090] Subtest lot-of-buffers: SUCCESS (1.011s)
[75.030354] [007/134] (948s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[75.086377] Starting subtest: yf-tiled-to-vebox-x-tiled
[75.091065] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[75.274699] [008/134] (948s left) kms_plane (plane-panning-top-left)
[75.369459] Starting subtest: plane-panning-top-left
[75.371713] Starting dynamic subtest: pipe-A
[77.119573] Dynamic subtest pipe-A: SUCCESS (1.750s)
[77.128838] Starting dynamic subtest: pipe-B
[79.457588] Dynamic subtest pipe-B: SUCCESS (2.335s)
[79.459552] Subtest plane-panning-top-left: SUCCESS (4.087s)
[80.281982] [009/134] (943s left) kms_psr (fbc-psr-cursor-plane-onoff)
[80.377889] Starting subtest: fbc-psr-cursor-plane-onoff
[80.380200] Starting dynamic subtest: eDP-1
[80.384663] Dynamic subtest eDP-1: SKIP (0.000s)
[80.389169] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[80.474704] [010/134] (943s left) kms_cursor_crc (cursor-tearing-position-change)
[80.589194] Starting subtest: cursor-tearing-position-change
[80.591512] Starting dynamic subtest: pipe-A-eDP-1
[81.165546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[81.174571] Starting dynamic subtest: pipe-D-eDP-1
[82.421314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.256s)
[82.423750] Subtest cursor-tearing-position-change: SUCCESS (1.831s)
[83.262257] [011/134] (940s left) kms_frontbuffer_tracking (basic)
[83.364027] Starting subtest: basic
[86.642707] Subtest basic: SUCCESS (3.282s)
[86.781893] [012/134] (936s left) gem_spin_batch (spin-each)
[86.857602] Starting subtest: spin-each
[90.210741] Subtest spin-each: SUCCESS (3.353s)
[91.002347] [013/134] (932s left) gem_exec_reloc (basic-gtt-cpu)
[91.063672] Subtest basic-gtt-cpu: SKIP (0.000s)
[91.156252] [014/134] (932s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[91.244416] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[91.273330] Starting dynamic subtest: pipe-A-plane-0
[91.562239] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[91.570840] Starting dynamic subtest: pipe-A-plane-3
[91.795376] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[91.802815] Starting dynamic subtest: pipe-A-plane-5
[91.806820] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[92.948112] Starting dynamic subtest: pipe-B-plane-0
[93.241376] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[93.250827] Starting dynamic subtest: pipe-B-plane-3
[93.474682] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[93.482337] Starting dynamic subtest: pipe-B-plane-5
[93.486749] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[93.797376] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.552s)
[94.639334] [015/134] (929s left) gem_render_copy (y-tiled-ccs-to-linear)
[94.705698] Starting subtest: y-tiled-ccs-to-linear
[94.710143] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[94.899699] [016/134] (928s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[95.000038] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[95.004613] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[95.103356] [017/134] (928s left) kms_psr (pr-sprite-render)
[95.203625] Starting subtest: pr-sprite-render
[95.208022] Subtest pr-sprite-render: SKIP (0.000s)
[95.285847] [018/134] (928s left) gen9_exec_parse (shadow-peek)
[95.349342] Subtest shadow-peek: SKIP (0.000s)
[95.409876] [019/134] (928s left) perf (invalid-remove-userspace-config)
[95.537563] Starting subtest: invalid-remove-userspace-config
[95.548698] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[95.588676] [020/134] (928s left) gem_ctx_param (invalid-size-set)
[95.654697] Starting subtest: invalid-size-set
[95.657110] Subtest invalid-size-set: SUCCESS (0.001s)
[95.779086] [021/134] (928s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[95.880259] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[95.882194] Starting dynamic subtest: pipe-A-eDP-1
[95.900737] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[95.908872] Starting dynamic subtest: pipe-B-eDP-1
[95.926086] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[95.933089] Starting dynamic subtest: pipe-C-eDP-1
[95.949997] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[95.958037] Starting dynamic subtest: pipe-D-eDP-1
[95.976293] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[95.980345] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[98.106821] [022/134] (925s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[98.162098] Starting subtest: invalid-bsd2-flag-on-blt
[98.164686] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[98.270853] [023/134] (925s left) gem_render_copy (yf-tiled-ccs-to-linear)
[98.331026] Starting subtest: yf-tiled-ccs-to-linear
[98.335556] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[98.529749] [024/134] (925s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[98.593207] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[98.697329] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[98.783151] [025/134] (925s left) gem_exec_fence (invalid-timeline-fence-array)
[99.352072] Starting subtest: invalid-timeline-fence-array
[99.357436] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[101.005190] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[101.009119] [026/134] (923s left) kms_chamelium_edid (dp-edid-read)
[101.394744] Subtest dp-edid-read: SKIP (0.000s)
[102.204383] [027/134] (921s left) gem_exec_params (invalid-bsd1-flag-on-render)
[102.273488] Starting subtest: invalid-bsd1-flag-on-render
[102.275952] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[102.399223] [028/134] (921s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[102.501166] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[103.512034] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.012s)
[103.679170] [029/134] (920s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[103.779050] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[103.780901] Starting dynamic subtest: pipe-A-eDP-1
[103.799218] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.808399] Starting dynamic subtest: pipe-B-eDP-1
[103.824596] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.832190] Starting dynamic subtest: pipe-C-eDP-1
[103.849510] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.857648] Starting dynamic subtest: pipe-D-eDP-1
[103.875493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.878802] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.004s)
[106.104960] [030/134] (918s left) gem_eio (kms)
[106.366843] Starting subtest: kms
[127.073065] Subtest kms: SUCCESS (20.705s)
[128.270468] [031/134] (896s left) kms_cursor_legacy (torture-move)
[128.397422] Starting subtest: torture-move
[128.399729] Starting dynamic subtest: pipe-A
[134.189477] Dynamic subtest pipe-A: SUCCESS (5.790s)
[134.199508] Starting dynamic subtest: pipe-B
[141.192623] Dynamic subtest pipe-B: SUCCESS (7.000s)
[141.208300] Starting dynamic subtest: pipe-C
[148.312362] Dynamic subtest pipe-C: SUCCESS (7.120s)
[148.323514] Starting dynamic subtest: pipe-D
[154.299558] Dynamic subtest pipe-D: SUCCESS (5.987s)
[154.308654] Starting dynamic subtest: all-pipes
[160.180137] Dynamic subtest all-pipes: SUCCESS (5.880s)
[160.182614] Subtest torture-move: SUCCESS (31.783s)
[160.347927] [032/134] (863s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[160.458869] Starting subtest: bad-pixel-format-yf-tiled-ccs
[160.461220] Starting dynamic subtest: pipe-A-eDP-1
[160.483811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[160.493864] Starting dynamic subtest: pipe-B-eDP-1
[160.514723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[160.522641] Starting dynamic subtest: pipe-C-eDP-1
[160.543678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[160.551433] Starting dynamic subtest: pipe-D-eDP-1
[160.573295] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[160.577410] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[162.727831] [033/134] (861s left) gem_exec_capture (pi)
[162.793165] Starting subtest: pi
[162.795561] Starting dynamic subtest: rcs0
[167.185554] Dynamic subtest rcs0: SUCCESS (4.395s)
[167.196368] Starting dynamic subtest: bcs0
[171.465415] Dynamic subtest bcs0: SUCCESS (4.278s)
[171.477029] Starting dynamic subtest: vcs0
[175.729274] Dynamic subtest vcs0: SUCCESS (4.263s)
[175.740661] Starting dynamic subtest: vcs1
[179.909041] Dynamic subtest vcs1: SUCCESS (4.179s)
[179.919829] Starting dynamic subtest: vecs0
[184.223973] Dynamic subtest vecs0: SUCCESS (4.312s)
[184.234938] Starting dynamic subtest: ccs0
[188.596325] Dynamic subtest ccs0: SUCCESS (4.372s)
[188.598825] Subtest pi: SUCCESS (25.807s)
[188.686882] [034/134] (835s left) syncobj_timeline (wait-all-snapshot)
[188.781733] Starting subtest: wait-all-snapshot
[188.863567] Subtest wait-all-snapshot: SUCCESS (0.081s)
[188.955277] [035/134] (835s left) kms_async_flips (test-cursor-atomic)
[189.067733] Starting subtest: test-cursor-atomic
[189.071670] Subtest test-cursor-atomic: SKIP (0.000s)
[190.251471] [036/134] (834s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[190.374831] Starting subtest: x-tiled-32bpp-rotate-180
[191.920954] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.545s)
[192.066801] [037/134] (832s left) i915_pm_freq_api (freq-reset)
[192.127229] Starting subtest: freq-reset
[192.129339] Starting dynamic subtest: gt0
[192.329113] Dynamic subtest gt0: SUCCESS (0.199s)
[192.337560] Starting dynamic subtest: gt1
[192.485072] Dynamic subtest gt1: SUCCESS (0.156s)
[192.487702] Subtest freq-reset: SUCCESS (0.357s)
[192.583119] [038/134] (832s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[192.694619] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[196.965237] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.275s)
[198.170339] [039/134] (826s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[198.271730] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[198.273922] Starting dynamic subtest: pipe-A-eDP-1
[198.298595] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.310101] Starting dynamic subtest: pipe-B-eDP-1
[198.333075] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.341667] Starting dynamic subtest: pipe-C-eDP-1
[198.364348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.373401] Starting dynamic subtest: pipe-D-eDP-1
[198.398489] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.402684] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[200.519830] [040/134] (824s left) gem_mmap (short-mmap)
[200.581817] Subtest short-mmap: SKIP (0.000s)
[200.648302] [041/134] (824s left) vgem_basic (dmabuf-export)
[200.692116] Starting subtest: dmabuf-export
[200.742244] Subtest dmabuf-export: SUCCESS (0.052s)
[200.855926] [042/134] (823s left) gem_render_copy (y-tiled)
[200.927958] Starting subtest: y-tiled
[200.932398] Subtest y-tiled: SKIP (0.000s)
[201.119382] [043/134] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[201.219684] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[208.891427] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.675s)
[209.040659] [044/134] (815s left) gem_exec_schedule (implicit-write-read)
[209.108051] Starting subtest: implicit-write-read
[209.110261] Starting dynamic subtest: rcs0
[209.210325] Dynamic subtest rcs0: SUCCESS (0.112s)
[209.221377] Starting dynamic subtest: vcs0
[209.287993] Dynamic subtest vcs0: SUCCESS (0.077s)
[209.298852] Starting dynamic subtest: vcs1
[209.362191] Dynamic subtest vcs1: SUCCESS (0.073s)
[209.374182] Starting dynamic subtest: vecs0
[209.436218] Dynamic subtest vecs0: SUCCESS (0.073s)
[209.447283] Starting dynamic subtest: ccs0
[209.522098] Dynamic subtest ccs0: SUCCESS (0.085s)
[209.524716] Subtest implicit-write-read: SUCCESS (0.424s)
[211.038400] [045/134] (813s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[211.136281] Starting subtest: 4-tiled-64bpp-rotate-90
[211.156869] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[211.294107] [046/134] (813s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[211.383907] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[211.386172] Starting dynamic subtest: A-eDP1
[220.269565] Dynamic subtest A-eDP1: SUCCESS (8.886s)
[220.280248] Starting dynamic subtest: B-eDP1
[229.193876] Dynamic subtest B-eDP1: SUCCESS (8.922s)
[229.204387] Starting dynamic subtest: C-eDP1
[238.118060] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[238.126708] Starting dynamic subtest: D-eDP1
[247.049091] Dynamic subtest D-eDP1: SUCCESS (8.929s)
[247.054093] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.672s)
[248.294673] [047/134] (776s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[248.397598] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[248.402093] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.515335] [048/134] (776s left) kms_color_pipeline (plane-lut1d)
[248.605619] Starting subtest: plane-lut1d
[248.619383] Starting dynamic subtest: pipe-A-eDP-1
[249.321453] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[250.056228] Starting dynamic subtest: pipe-B-eDP-1
[250.866059] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[251.376075] Starting dynamic subtest: pipe-C-eDP-1
[252.197222] Dynamic subtest pipe-C-eDP-1: FAIL (0.236s)
[252.711716] Starting dynamic subtest: pipe-D-eDP-1
[253.579583] Dynamic subtest pipe-D-eDP-1: FAIL (0.279s)
[253.581913] Subtest plane-lut1d: FAIL (4.658s)
[254.096964] [049/134] (770s left) i915_pm_rc6_residency (rc6-accuracy)
[254.158287] Starting subtest: rc6-accuracy
[254.160581] Starting dynamic subtest: gt0
[257.329891] Dynamic subtest gt0: SUCCESS (3.169s)
[257.339496] Starting dynamic subtest: gt1
[260.501104] Dynamic subtest gt1: SUCCESS (3.168s)
[260.503829] Subtest rc6-accuracy: SUCCESS (6.343s)
[260.587380] [050/134] (764s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[260.713551] Starting subtest: basic-flip-before-cursor-atomic
[261.644512] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.930s)
[262.540584] [051/134] (762s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[262.642572] Starting subtest: psr-2p-primscrn-spr-indfb-move
[262.646623] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[262.746047] [052/134] (762s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[262.847636] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[262.851782] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[262.939540] [053/134] (762s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[267.886325] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[267.890815] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[268.777923] [054/134] (756s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[268.856765] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[268.960306] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[269.047073] [055/134] (756s left) gem_mmap_wc (bad-size)
[269.111876] Subtest bad-size: SKIP (0.000s)
[269.183515] [056/134] (756s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[269.289318] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[269.293673] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[269.415262] [057/134] (755s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[269.519802] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[269.523882] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[269.665743] [058/134] (755s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[269.790343] Starting subtest: cursorA-vs-flipB-atomic
[269.794843] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[269.942875] [059/134] (755s left) sysfs_heartbeat_interval (nopreempt)
[270.012594] Starting subtest: nopreempt
[270.014702] Starting dynamic subtest: vecs0
[279.918077] Dynamic subtest vecs0: SUCCESS (9.901s)
[279.934056] Starting dynamic subtest: ccs0
[283.998206] Dynamic subtest ccs0: SUCCESS (4.080s)
[284.010268] Starting dynamic subtest: vcs0
[293.937370] Dynamic subtest vcs0: SUCCESS (9.937s)
[293.949428] Starting dynamic subtest: bcs0
[298.036189] Dynamic subtest bcs0: SUCCESS (4.096s)
[298.047582] Starting dynamic subtest: rcs0
[302.209158] Dynamic subtest rcs0: SUCCESS (4.172s)
[302.220585] Starting dynamic subtest: vcs1
[310.950312] Dynamic subtest vcs1: SUCCESS (8.739s)
[310.952926] Subtest nopreempt: SUCCESS (40.938s)
[311.043073] [060/134] (714s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[311.155479] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[311.159964] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[311.282396] [061/134] (714s left) gem_wait (busy)
[311.356356] Starting subtest: busy
[311.358557] Starting dynamic subtest: all-engines
[312.916811] Dynamic subtest all-engines: SUCCESS (1.561s)
[312.929503] Starting dynamic subtest: rcs0
[313.459894] Dynamic subtest rcs0: SUCCESS (0.541s)
[313.470737] Starting dynamic subtest: bcs0
[314.000516] Dynamic subtest bcs0: SUCCESS (0.539s)
[314.009310] Starting dynamic subtest: vcs0
[315.924560] Dynamic subtest vcs0: SUCCESS (1.922s)
[315.936760] Starting dynamic subtest: vcs1
[317.908596] Dynamic subtest vcs1: SUCCESS (1.981s)
[317.920215] Starting dynamic subtest: vecs0
[319.892605] Dynamic subtest vecs0: SUCCESS (1.981s)
[319.904458] Starting dynamic subtest: ccs0
[320.435514] Dynamic subtest ccs0: SUCCESS (0.542s)
[320.438099] Subtest busy: SUCCESS (9.082s)
[320.646875] [062/134] (704s left) kms_setmode (clone-exclusive-crtc)
[320.709114] Starting subtest: clone-exclusive-crtc
[320.715867] Subtest clone-exclusive-crtc: SKIP (0.000s)
[320.837173] [063/134] (704s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[325.864026] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[325.869293] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[326.708146] [064/134] (698s left) sw_sync (sync_merge_same)
[326.750408] Starting subtest: sync_merge_same
[326.752743] Subtest sync_merge_same: SUCCESS (0.000s)
[326.830376] [065/134] (698s left) kms_hdr (static-toggle)
[326.933099] Starting subtest: static-toggle
[326.939577] Subtest static-toggle: SKIP (0.000s)
[327.016406] [066/134] (698s left) gem_exec_await (wide-contexts)
[327.209782] Starting subtest: wide-contexts
[350.697965] Subtest wide-contexts: SUCCESS (23.488s)
[350.908984] [067/134] (674s left) kms_invalid_mode (uint-max-clock)
[351.042575] Starting subtest: uint-max-clock
[351.044894] Starting dynamic subtest: pipe-A-eDP-1
[351.333261] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[351.343056] Starting dynamic subtest: pipe-B-eDP-1
[351.345609] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[351.354190] Starting dynamic subtest: pipe-C-eDP-1
[351.356667] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[351.364921] Starting dynamic subtest: pipe-D-eDP-1
[351.367211] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[351.369124] Subtest uint-max-clock: SUCCESS (0.294s)
[352.142155] [068/134] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[352.238770] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[356.014650] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.780s)
[357.169796] [069/134] (668s left) kms_pm_rpm (modeset-non-lpsp)
[359.124512] Starting subtest: modeset-non-lpsp
[360.280998] Subtest modeset-non-lpsp: SKIP (1.157s)
[360.671323] [070/134] (665s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[360.782235] Starting subtest: fbc-pr-cursor-mmap-cpu
[360.786242] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[360.867176] [071/134] (665s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[360.963803] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[364.904689] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.944s)
[366.051019] [072/134] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[366.165227] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[366.169677] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[366.312244] [073/134] (659s left) i915_pm_rps (thresholds-idle)
[366.375407] Starting subtest: thresholds-idle
[366.379521] Subtest thresholds-idle: SKIP (0.001s)
[366.498619] [074/134] (659s left) kms_vblank (query-idle-hang)
[366.597948] Starting subtest: query-idle-hang
[366.600257] Starting dynamic subtest: pipe-A-eDP-1
[392.669244] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.071s)
[392.683128] Starting dynamic subtest: pipe-D-eDP-1
[417.687579] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[417.689900] Subtest query-idle-hang: SUCCESS (51.091s)
[418.502868] [075/134] (607s left) perf_pmu (most-busy-idle-check-all)
[418.548156] Starting subtest: most-busy-idle-check-all
[418.550474] Starting dynamic subtest: rcs0
[419.926131] Dynamic subtest rcs0: SUCCESS (1.378s)
[419.939693] Starting dynamic subtest: bcs0
[421.909482] Dynamic subtest bcs0: SUCCESS (1.979s)
[421.921982] Starting dynamic subtest: vcs0
[423.893622] Dynamic subtest vcs0: SUCCESS (1.980s)
[423.905704] Starting dynamic subtest: vcs1
[425.877070] Dynamic subtest vcs1: SUCCESS (1.980s)
[425.889768] Starting dynamic subtest: vecs0
[427.926040] Dynamic subtest vecs0: SUCCESS (2.045s)
[427.937994] Starting dynamic subtest: ccs0
[429.909631] Dynamic subtest ccs0: SUCCESS (1.981s)
[429.912660] Subtest most-busy-idle-check-all: SUCCESS (11.364s)
[430.043654] [076/134] (596s left) kms_atomic_interruptible (universal-setplane-cursor)
[430.155068] Starting subtest: universal-setplane-cursor
[430.157357] Starting dynamic subtest: pipe-A-eDP-1
[437.610781] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.454s)
[437.613173] Subtest universal-setplane-cursor: SUCCESS (7.456s)
[438.475263] [077/134] (587s left) gem_userptr_blits (process-exit-busy)
[438.557191] Starting subtest: process-exit-busy
[438.572443] Subtest process-exit-busy: SUCCESS (0.016s)
[438.726258] [078/134] (587s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[438.828633] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[438.832609] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[438.953804] [079/134] (587s left) gem_lmem_swapping (heavy-verify-multi)
[439.002327] Subtest heavy-verify-multi: SKIP (0.000s)
[439.047836] [080/134] (587s left) gen9_exec_parse (bb-start-cmd)
[439.110739] Subtest bb-start-cmd: SKIP (0.000s)
[439.191410] [081/134] (587s left) fbdev (unaligned-read)
[439.233406] Starting subtest: unaligned-read
[439.249056] Subtest unaligned-read: SUCCESS (0.016s)
[439.313955] [082/134] (587s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[439.729607] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[440.584089] [083/134] (585s left) gem_ppgtt (blt-vs-render-ctx0)
[440.640424] Starting subtest: blt-vs-render-ctx0
[473.380610] Subtest blt-vs-render-ctx0: SUCCESS (32.736s)
[473.555253] [084/134] (552s left) core_setmaster_vs_auth
[473.767978] [085/134] (552s left) prime_busy (hang)
[473.834660] Starting subtest: hang
[473.837060] Starting dynamic subtest: rcs0
[500.409087] Dynamic subtest rcs0: SUCCESS (26.569s)
[500.418040] Starting dynamic subtest: bcs0
[507.554085] Dynamic subtest bcs0: SUCCESS (7.143s)
[507.564494] Starting dynamic subtest: vcs0
[514.594110] Dynamic subtest vcs0: SUCCESS (7.040s)
[514.602959] Starting dynamic subtest: vcs1
[521.572071] Dynamic subtest vcs1: SUCCESS (6.977s)
[521.580892] Starting dynamic subtest: vecs0
[528.540790] Dynamic subtest vecs0: SUCCESS (6.970s)
[528.549793] Starting dynamic subtest: ccs0
[542.446028] Dynamic subtest ccs0: SUCCESS (13.898s)
[542.448644] Subtest hang: SUCCESS (68.605s)
[542.597536] [086/134] (483s left) gem_eio (unwedge-stress)
[542.793612] Starting subtest: unwedge-stress
[542.795583] Starting dynamic subtest: render
[547.139617] Dynamic subtest render: SUCCESS (4.344s)
[547.154471] Starting dynamic subtest: bsd1
[565.323056] Dynamic subtest bsd1: SUCCESS (18.179s)
[565.340077] Starting dynamic subtest: bsd2
[583.370457] Dynamic subtest bsd2: SUCCESS (18.044s)
[583.386945] Starting dynamic subtest: blt
[583.391062] Dynamic subtest blt: SKIP (0.000s)
[583.399918] Starting dynamic subtest: vebox
[601.347237] Dynamic subtest vebox: SUCCESS (17.974s)
[601.349355] Subtest unwedge-stress: SUCCESS (58.545s)
[602.961070] [087/134] (423s left) kms_cursor_crc (cursor-random-256x256)
[603.239550] Starting subtest: cursor-random-256x256
[603.244167] Starting dynamic subtest: pipe-A-eDP-1
[606.617804] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.371s)
[606.644298] Starting dynamic subtest: pipe-D-eDP-1
[610.616751] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.978s)
[610.619180] Subtest cursor-random-256x256: SUCCESS (7.376s)
[611.469166] [088/134] (415s left) syncobj_timeline (multi-wait-submitted-signaled)
[611.534348] Starting subtest: multi-wait-submitted-signaled
[611.537291] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[611.652880] [089/134] (415s left) kms_dsc (dsc-with-formats)
[611.744096] Starting subtest: dsc-with-formats
[611.784080] Subtest dsc-with-formats: SKIP (0.001s)
[611.842330] [090/134] (414s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[611.950931] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[618.591846] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.642s)
[618.746752] [091/134] (408s left) api_intel_allocator (reopen-fork)
[618.812862] Starting subtest: reopen-fork
[622.435992] Subtest reopen-fork: SUCCESS (3.624s)
[622.530378] [092/134] (404s left) gem_exec_whisper (basic-fds-priority-all)
[622.602829] Starting subtest: basic-fds-priority-all
[646.138081] Subtest basic-fds-priority-all: SUCCESS (23.528s)
[646.332896] [093/134] (380s left) gem_exec_fence (basic-wait-all)
[646.396473] Starting subtest: basic-wait-all
[646.512982] Subtest basic-wait-all: SUCCESS (0.117s)
[647.998678] [094/134] (378s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[648.102863] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[648.105104] Starting dynamic subtest: pipe-A-eDP-1
[648.160821] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[648.170174] Starting dynamic subtest: pipe-B-eDP-1
[648.225580] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[648.235981] Starting dynamic subtest: pipe-C-eDP-1
[648.292438] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[648.302650] Starting dynamic subtest: pipe-D-eDP-1
[648.358082] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[648.362090] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[650.388190] [095/134] (376s left) kms_psr (fbc-psr2-no-drrs)
[650.483060] Starting subtest: fbc-psr2-no-drrs
[650.485400] Starting dynamic subtest: eDP-1
[650.489712] Dynamic subtest eDP-1: SKIP (0.000s)
[650.493996] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[650.571199] [096/134] (376s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[650.669783] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[650.673857] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[650.804512] [097/134] (376s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[650.906663] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[650.911043] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[651.031794] [098/134] (376s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[651.139666] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[654.803065] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.668s)
[655.974808] [099/134] (371s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[656.074784] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[656.077085] Starting dynamic subtest: pipe-A
[656.099671] Dynamic subtest pipe-A: SKIP (0.019s)
[656.109102] Starting dynamic subtest: pipe-B
[656.134735] Dynamic subtest pipe-B: SKIP (0.033s)
[656.144294] Starting dynamic subtest: pipe-C
[656.166962] Dynamic subtest pipe-C: SKIP (0.033s)
[656.176208] Starting dynamic subtest: pipe-D
[656.205290] Dynamic subtest pipe-D: SKIP (0.035s)
[656.209571] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.125s)
[656.329782] [100/134] (370s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[656.412760] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[656.417205] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[656.511113] [101/134] (370s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[656.638066] Starting subtest: flip-vs-cursor-busy-crc-atomic
[657.462121] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.823s)
[658.296500] [102/134] (368s left) core_getstats (basic)
[658.353567] Starting subtest: basic
[658.355890] Subtest basic: SUCCESS (0.000s)
[658.480546] [103/134] (368s left) gem_mmap_gtt (hang-busy)
[658.529227] Subtest hang-busy: SKIP (0.000s)
[658.589966] [104/134] (368s left) kms_flip (flip-vs-expired-vblank-interruptible)
[658.692994] Starting subtest: flip-vs-expired-vblank-interruptible
[658.695259] Starting dynamic subtest: A-eDP1
[667.379732] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[667.389991] Starting dynamic subtest: B-eDP1
[676.003925] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[676.014060] Starting dynamic subtest: C-eDP1
[684.619515] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[684.632227] Starting dynamic subtest: D-eDP1
[693.245058] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[693.250484] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.554s)
[694.437401] [105/134] (332s left) gem_exec_schedule (preempt-queue-contexts)
[694.516914] Subtest preempt-queue-contexts: SKIP (0.000s)
[694.817783] [106/134] (332s left) perf (oa-formats)
[694.917886] Starting subtest: oa-formats
[694.920426] Starting dynamic subtest: 0-rcs0
[694.934068] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[694.945173] Starting dynamic subtest: 1-vcs1
[694.956311] Dynamic subtest 1-vcs1: SUCCESS (0.021s)
[694.958513] Subtest oa-formats: SUCCESS (0.039s)
[695.004050] [107/134] (332s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[695.106532] Starting subtest: fbcpsr-modesetfrombusy
[701.308525] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.206s)
[701.494475] [108/134] (326s left) kms_flip (2x-dpms-vs-vblank-race)
[701.587226] Starting subtest: 2x-dpms-vs-vblank-race
[701.596662] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[701.704455] [109/134] (325s left) gem_exec_params (readonly)
[701.774183] Starting subtest: readonly
[701.778128] Subtest readonly: SUCCESS (0.003s)
[701.931984] [110/134] (325s left) kms_vblank (invalid)
[702.028488] Starting subtest: invalid
[702.030130] Starting dynamic subtest: pipe-A-eDP-1
[702.438087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.408s)
[702.439980] Subtest invalid: SUCCESS (0.409s)
[703.318791] [111/134] (324s left) gem_exec_reloc (basic-cpu-read-noreloc)
[703.379453] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[703.463050] [112/134] (324s left) gem_ctx_persistence (engines-hostile)
[703.530595] Starting subtest: engines-hostile
[703.532896] Starting dynamic subtest: rcs0
[703.663575] Dynamic subtest rcs0: SUCCESS (0.133s)
[703.676215] Starting dynamic subtest: bcs0
[703.788352] Dynamic subtest bcs0: SUCCESS (0.122s)
[703.800946] Starting dynamic subtest: vcs0
[703.910921] Dynamic subtest vcs0: SUCCESS (0.121s)
[703.923750] Starting dynamic subtest: vcs1
[704.019457] Dynamic subtest vcs1: SUCCESS (0.107s)
[704.029143] Starting dynamic subtest: vecs0
[704.141301] Dynamic subtest vecs0: SUCCESS (0.120s)
[704.153978] Starting dynamic subtest: ccs0
[704.264922] Dynamic subtest ccs0: SUCCESS (0.122s)
[704.267676] Subtest engines-hostile: SUCCESS (0.735s)
[704.357522] [113/134] (323s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[704.459822] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[704.463391] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[704.584856] [114/134] (323s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[704.678955] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[704.682352] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[704.797543] [115/134] (322s left) gem_caching (writes)
[704.854716] Subtest writes: SKIP (0.000s)
[704.937712] [116/134] (322s left) kms_pm_backlight (fade-with-suspend)
[705.046495] Starting subtest: fade-with-suspend
[721.096329] Starting dynamic subtest: eDP-1
[723.791237] Dynamic subtest eDP-1: SUCCESS (2.691s)
[723.793810] Subtest fade-with-suspend: SUCCESS (4.019s)
[724.613304] [117/134] (303s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[724.724901] Starting subtest: coverage-vs-premult-vs-constant
[725.017846] Starting dynamic subtest: pipe-A-eDP-1
[725.620791] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[725.631557] Starting dynamic subtest: pipe-D-eDP-1
[726.938102] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[726.940971] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.211s)
[727.789631] [118/134] (300s left) kms_lease (master-vs-lease)
[727.901888] Starting subtest: master-vs-lease
[727.904645] Subtest master-vs-lease: SUCCESS (0.002s)
[728.032678] [119/134] (299s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[728.139822] Starting subtest: psr-rgb565-draw-mmap-wc
[734.872115] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.730s)
[734.999054] [120/134] (293s left) kms_addfb_basic (addfb25-4-tiled)
[735.112565] Starting subtest: addfb25-4-tiled
[735.114779] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[735.238318] [121/134] (292s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[735.328766] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[735.333805] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[735.415941] [122/134] (292s left) kms_plane_multiple (2x-tiling-x)
[735.505730] Starting subtest: 2x-tiling-x
[735.510820] Subtest 2x-tiling-x: SKIP (0.000s)
[735.592559] [123/134] (292s left) kms_psr (psr2-primary-render)
[735.698213] Starting subtest: psr2-primary-render
[735.700862] Starting dynamic subtest: eDP-1
[737.424882] Dynamic subtest eDP-1: SUCCESS (1.725s)
[737.427806] Subtest psr2-primary-render: SUCCESS (1.726s)
[738.301345] [124/134] (289s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[738.375812] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[738.482403] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[738.605086] [125/134] (289s left) gem_exec_balancer (full)
[738.672841] Starting subtest: full
[743.426003] Subtest full: SUCCESS (4.755s)
[743.751070] [126/134] (284s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[743.848835] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[743.853573] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[743.973091] [127/134] (284s left) gem_mmap_wc (write-read)
[744.036520] Subtest write-read: SKIP (0.000s)
[744.095153] [128/134] (284s left) gem_ctx_persistence (process)
[744.158749] Starting subtest: process
[744.387405] Subtest process: SUCCESS (0.231s)
[744.485263] [129/134] (283s left) gem_ctx_param (non-root-set)
[744.554456] Starting subtest: non-root-set
[744.586306] Subtest non-root-set: SUCCESS (0.032s)
[744.685968] [130/134] (283s left) sw_sync (timeline_closed)
[744.726500] Starting subtest: timeline_closed
[744.728706] Subtest timeline_closed: SUCCESS (0.000s)
[744.799941] [131/134] (283s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[744.898293] Starting subtest: primary-4-tiled-reflect-x-180
[752.315704] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.417s)
[753.573192] [132/134] (274s left) gem_exec_parallel (basic)
[753.640483] Starting subtest: basic
[753.643156] Starting dynamic subtest: rcs0
[755.336437] Dynamic subtest rcs0: SUCCESS (1.697s)
[755.349198] Starting dynamic subtest: bcs0
[757.048756] Dynamic subtest bcs0: SUCCESS (1.711s)
[757.061906] Starting dynamic subtest: vcs0
[758.645495] Dynamic subtest vcs0: SUCCESS (1.597s)
[758.656114] Starting dynamic subtest: vcs1
[760.597939] Dynamic subtest vcs1: SUCCESS (1.951s)
[760.615376] Starting dynamic subtest: vecs0
[762.580497] Dynamic subtest vecs0: SUCCESS (1.981s)
[762.591814] Starting dynamic subtest: ccs0
[764.375633] Dynamic subtest ccs0: SUCCESS (1.796s)
[764.378567] Subtest basic: SUCCESS (10.741s)
[764.578335] [133/134] (264s left) kms_content_protection (uevent-hdcp14)
[764.734414] Starting subtest: uevent-hdcp14
[764.739859] Subtest uevent-hdcp14: SKIP (0.000s)
[764.900708] [134/134] (263s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[764.961493] Starting subtest: multi-wait-all-for-submit-available-signaled
[764.963866] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[765.082177] 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.