[59.280865] Initializing watchdogs
[59.280916]   /dev/watchdog0
[59.295297] [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.299846] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.302344] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.305754] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[59.593898] Starting subtest: cursor-offscreen-256x85
[59.647638] Subtest cursor-offscreen-256x85: SKIP (0.050s)
[59.832414] [002/134] (960s left) gem_mmap_gtt (cpuset-big-copy-odd)
[59.894037] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[59.953276] [003/134] (959s left) gem_ctx_engines (execute-allforone)
[60.022878] Starting subtest: execute-allforone
[60.036261] Subtest execute-allforone: SUCCESS (0.013s)
[62.022987] [004/134] (957s left) perf_pmu (busy-idle)
[62.061578] Starting subtest: busy-idle
[62.063875] Starting dynamic subtest: rcs0
[62.760287] Dynamic subtest rcs0: SUCCESS (0.697s)
[62.768913] Starting dynamic subtest: bcs0
[63.434856] Dynamic subtest bcs0: SUCCESS (0.672s)
[63.443918] Starting dynamic subtest: vcs0
[64.917921] Dynamic subtest vcs0: SUCCESS (1.477s)
[64.926911] Starting dynamic subtest: vcs1
[66.837229] Dynamic subtest vcs1: SUCCESS (1.915s)
[66.851513] Starting dynamic subtest: vecs0
[68.885867] Dynamic subtest vecs0: SUCCESS (2.045s)
[68.896581] Starting dynamic subtest: ccs0
[69.563482] Dynamic subtest ccs0: SUCCESS (0.677s)
[69.565976] Subtest busy-idle: SUCCESS (7.489s)
[69.687762] [005/134] (950s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[69.789365] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[70.458478] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s)
[70.678291] [006/134] (949s left) api_intel_bb (lot-of-buffers)
[70.739916] Starting subtest: lot-of-buffers
[71.742122] Subtest lot-of-buffers: SUCCESS (1.002s)
[71.987802] [007/134] (948s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[72.045289] Starting subtest: yf-tiled-to-vebox-x-tiled
[72.049939] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[72.234799] [008/134] (947s left) kms_plane (plane-panning-top-left)
[72.332109] Starting subtest: plane-panning-top-left
[72.334109] Starting dynamic subtest: pipe-A
[74.069999] Dynamic subtest pipe-A: SUCCESS (1.737s)
[74.079785] Starting dynamic subtest: pipe-B
[76.454391] Dynamic subtest pipe-B: SUCCESS (2.383s)
[76.456808] Subtest plane-panning-top-left: SUCCESS (4.122s)
[77.263494] [009/134] (942s left) kms_psr (fbc-psr-cursor-plane-onoff)
[77.354985] Starting subtest: fbc-psr-cursor-plane-onoff
[77.357351] Starting dynamic subtest: eDP-1
[77.361783] Dynamic subtest eDP-1: SKIP (0.000s)
[77.366138] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[77.436154] [010/134] (942s left) kms_cursor_crc (cursor-tearing-position-change)
[77.549679] Starting subtest: cursor-tearing-position-change
[77.552029] Starting dynamic subtest: pipe-A-eDP-1
[78.124291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[78.133268] Starting dynamic subtest: pipe-D-eDP-1
[79.393493] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.267s)
[79.395548] Subtest cursor-tearing-position-change: SUCCESS (1.842s)
[80.226992] [011/134] (939s left) kms_frontbuffer_tracking (basic)
[80.331330] Starting subtest: basic
[83.554636] Subtest basic: SUCCESS (3.226s)
[83.692325] [012/134] (936s left) gem_spin_batch (spin-each)
[83.764868] Starting subtest: spin-each
[87.121753] Subtest spin-each: SUCCESS (3.357s)
[88.946815] [013/134] (931s left) gem_exec_reloc (basic-gtt-cpu)
[89.026652] Subtest basic-gtt-cpu: SKIP (0.000s)
[89.093428] [014/134] (931s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[89.197825] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[89.224553] Starting dynamic subtest: pipe-A-plane-0
[89.513474] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[89.521199] Starting dynamic subtest: pipe-A-plane-3
[89.749601] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[89.758546] Starting dynamic subtest: pipe-A-plane-5
[89.763371] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[90.821507] Starting dynamic subtest: pipe-B-plane-0
[91.114598] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[91.122758] Starting dynamic subtest: pipe-B-plane-3
[91.348667] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[91.362115] Starting dynamic subtest: pipe-B-plane-5
[91.366787] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[91.656861] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.461s)
[92.503868] [015/134] (927s left) gem_render_copy (y-tiled-ccs-to-linear)
[92.568324] Starting subtest: y-tiled-ccs-to-linear
[92.573014] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[92.758322] [016/134] (927s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[92.858067] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[92.862537] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[92.966785] [017/134] (927s left) kms_psr (pr-sprite-render)
[93.064884] Starting subtest: pr-sprite-render
[93.069057] Subtest pr-sprite-render: SKIP (0.000s)
[93.145328] [018/134] (927s left) gen9_exec_parse (shadow-peek)
[93.205981] Subtest shadow-peek: SKIP (0.000s)
[93.275074] [019/134] (927s left) perf (invalid-remove-userspace-config)
[93.396371] Starting subtest: invalid-remove-userspace-config
[93.405532] Subtest invalid-remove-userspace-config: SUCCESS (0.008s)
[93.439243] [020/134] (927s left) gem_ctx_param (invalid-size-set)
[93.501751] Starting subtest: invalid-size-set
[93.504228] Subtest invalid-size-set: SUCCESS (0.001s)
[93.623031] [021/134] (926s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[93.714103] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[93.716072] Starting dynamic subtest: pipe-A-eDP-1
[93.735986] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[93.745489] Starting dynamic subtest: pipe-B-eDP-1
[93.763171] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[93.769955] Starting dynamic subtest: pipe-C-eDP-1
[93.788038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[93.795343] Starting dynamic subtest: pipe-D-eDP-1
[93.813427] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[93.817076] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[95.975715] [022/134] (924s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.037051] Starting subtest: invalid-bsd2-flag-on-blt
[96.039442] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.155604] [023/134] (924s left) gem_render_copy (yf-tiled-ccs-to-linear)
[96.210901] Starting subtest: yf-tiled-ccs-to-linear
[96.215280] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[96.412566] [024/134] (924s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[96.469831] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[96.578154] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[96.662376] [025/134] (924s left) gem_exec_fence (invalid-timeline-fence-array)
[97.249705] Starting subtest: invalid-timeline-fence-array
[97.255466] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[99.035584] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[99.038859] [026/134] (921s left) kms_chamelium_edid (dp-edid-read)
[99.435629] Subtest dp-edid-read: SKIP (0.000s)
[100.282880] [027/134] (920s left) gem_exec_params (invalid-bsd1-flag-on-render)
[100.351196] Starting subtest: invalid-bsd1-flag-on-render
[100.353477] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[100.478058] [028/134] (920s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[100.584149] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[101.607395] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.024s)
[101.751251] [029/134] (919s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[101.846886] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[101.848657] Starting dynamic subtest: pipe-A-eDP-1
[101.867155] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.874964] Starting dynamic subtest: pipe-B-eDP-1
[101.901082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.908273] Starting dynamic subtest: pipe-C-eDP-1
[101.925188] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.932171] Starting dynamic subtest: pipe-D-eDP-1
[101.949961] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.953278] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[104.184973] [030/134] (916s left) gem_eio (kms)
[104.454761] Starting subtest: kms
[125.112214] Subtest kms: SUCCESS (20.654s)
[126.307181] [031/134] (894s left) kms_cursor_legacy (torture-move)
[126.451444] Starting subtest: torture-move
[126.453782] Starting dynamic subtest: pipe-A
[132.588741] Dynamic subtest pipe-A: SUCCESS (6.134s)
[132.602826] Starting dynamic subtest: pipe-B
[139.461705] Dynamic subtest pipe-B: SUCCESS (6.871s)
[139.473165] Starting dynamic subtest: pipe-C
[146.811367] Dynamic subtest pipe-C: SUCCESS (7.349s)
[146.821616] Starting dynamic subtest: pipe-D
[153.636517] Dynamic subtest pipe-D: SUCCESS (6.823s)
[153.647464] Starting dynamic subtest: all-pipes
[160.720753] Dynamic subtest all-pipes: SUCCESS (7.082s)
[160.723235] Subtest torture-move: SUCCESS (34.266s)
[160.887766] [032/134] (860s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[161.009819] Starting subtest: bad-pixel-format-yf-tiled-ccs
[161.012160] Starting dynamic subtest: pipe-A-eDP-1
[161.033566] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.046379] Starting dynamic subtest: pipe-B-eDP-1
[161.064648] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[161.074867] Starting dynamic subtest: pipe-C-eDP-1
[161.100406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[161.108560] Starting dynamic subtest: pipe-D-eDP-1
[161.130044] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[161.134058] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.007s)
[163.270046] [033/134] (857s left) gem_exec_capture (pi)
[163.338244] Starting subtest: pi
[163.340547] Starting dynamic subtest: rcs0
[167.894774] Dynamic subtest rcs0: SUCCESS (4.556s)
[167.905377] Starting dynamic subtest: bcs0
[172.112232] Dynamic subtest bcs0: SUCCESS (4.216s)
[172.123328] Starting dynamic subtest: vcs0
[176.322084] Dynamic subtest vcs0: SUCCESS (4.208s)
[176.330247] Starting dynamic subtest: vcs1
[180.623808] Dynamic subtest vcs1: SUCCESS (4.300s)
[180.634606] Starting dynamic subtest: vecs0
[184.889172] Dynamic subtest vecs0: SUCCESS (4.264s)
[184.904081] Starting dynamic subtest: ccs0
[189.204106] Dynamic subtest ccs0: SUCCESS (4.314s)
[189.206558] Subtest pi: SUCCESS (25.866s)
[189.297718] [034/134] (831s left) syncobj_timeline (wait-all-snapshot)
[189.406880] Starting subtest: wait-all-snapshot
[189.489044] Subtest wait-all-snapshot: SUCCESS (0.081s)
[189.576583] [035/134] (831s left) kms_async_flips (test-cursor-atomic)
[189.675903] Starting subtest: test-cursor-atomic
[189.680187] Subtest test-cursor-atomic: SKIP (0.000s)
[190.890770] [036/134] (830s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[191.004080] Starting subtest: x-tiled-32bpp-rotate-180
[192.526598] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.523s)
[192.680876] [037/134] (828s left) i915_pm_freq_api (freq-reset)
[192.742132] Starting subtest: freq-reset
[192.743899] Starting dynamic subtest: gt0
[192.938449] Dynamic subtest gt0: SUCCESS (0.196s)
[192.953395] Starting dynamic subtest: gt1
[193.097809] Dynamic subtest gt1: SUCCESS (0.158s)
[193.100573] Subtest freq-reset: SUCCESS (0.356s)
[193.195802] [038/134] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[193.306295] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[197.524506] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.219s)
[198.683263] [039/134] (822s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[198.785083] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[198.787464] Starting dynamic subtest: pipe-A-eDP-1
[198.814140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[198.830086] Starting dynamic subtest: pipe-B-eDP-1
[198.853928] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[198.865201] Starting dynamic subtest: pipe-C-eDP-1
[198.888467] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[198.896971] Starting dynamic subtest: pipe-D-eDP-1
[198.920724] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[198.924767] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[201.059324] [040/134] (820s left) gem_mmap (short-mmap)
[201.124507] Subtest short-mmap: SKIP (0.000s)
[201.185936] [041/134] (820s left) vgem_basic (dmabuf-export)
[201.238064] Starting subtest: dmabuf-export
[201.265545] Subtest dmabuf-export: SUCCESS (0.030s)
[201.410915] [042/134] (819s left) gem_render_copy (y-tiled)
[201.467875] Starting subtest: y-tiled
[201.472533] Subtest y-tiled: SKIP (0.000s)
[201.661635] [043/134] (819s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[201.758645] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[209.462221] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.707s)
[209.610118] [044/134] (811s left) gem_exec_schedule (implicit-write-read)
[209.694137] Starting subtest: implicit-write-read
[209.696318] Starting dynamic subtest: rcs0
[209.792231] Dynamic subtest rcs0: SUCCESS (0.102s)
[209.804085] Starting dynamic subtest: vcs0
[209.875853] Dynamic subtest vcs0: SUCCESS (0.083s)
[209.886026] Starting dynamic subtest: vcs1
[209.951258] Dynamic subtest vcs1: SUCCESS (0.075s)
[209.963252] Starting dynamic subtest: vecs0
[210.035865] Dynamic subtest vecs0: SUCCESS (0.084s)
[210.045834] Starting dynamic subtest: ccs0
[210.130342] Dynamic subtest ccs0: SUCCESS (0.094s)
[210.132604] Subtest implicit-write-read: SUCCESS (0.442s)
[211.019057] [045/134] (810s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[211.121181] Starting subtest: 4-tiled-64bpp-rotate-90
[211.141055] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.019s)
[211.298833] [046/134] (810s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[211.384420] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[211.386670] Starting dynamic subtest: A-eDP1
[220.319647] Dynamic subtest A-eDP1: SUCCESS (8.934s)
[220.330363] Starting dynamic subtest: B-eDP1
[229.249641] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[229.260799] Starting dynamic subtest: C-eDP1
[238.175739] Dynamic subtest C-eDP1: SUCCESS (8.924s)
[238.187198] Starting dynamic subtest: D-eDP1
[247.107936] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[247.113427] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.727s)
[248.346354] [047/134] (773s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[248.453145] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[248.457217] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[248.586397] [048/134] (773s left) kms_color_pipeline (plane-lut1d)
[248.696563] Starting subtest: plane-lut1d
[248.713704] Starting dynamic subtest: pipe-A-eDP-1
[249.428550] Dynamic subtest pipe-A-eDP-1: FAIL (0.354s)
[250.117064] Starting dynamic subtest: pipe-B-eDP-1
[250.948827] Dynamic subtest pipe-B-eDP-1: FAIL (0.328s)
[251.555614] Starting dynamic subtest: pipe-C-eDP-1
[252.414253] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[252.891418] Starting dynamic subtest: pipe-D-eDP-1
[253.729742] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[253.731784] Subtest plane-lut1d: FAIL (4.734s)
[254.284659] [049/134] (767s left) i915_pm_rc6_residency (rc6-accuracy)
[254.350368] Starting subtest: rc6-accuracy
[254.352620] Starting dynamic subtest: gt0
[257.525855] Dynamic subtest gt0: SUCCESS (3.170s)
[257.535686] Starting dynamic subtest: gt1
[260.698394] Dynamic subtest gt1: SUCCESS (3.168s)
[260.700883] Subtest rc6-accuracy: SUCCESS (6.345s)
[260.782025] [050/134] (760s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[260.902385] Starting subtest: basic-flip-before-cursor-atomic
[261.816773] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.914s)
[262.627855] [051/134] (759s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[262.727296] Starting subtest: psr-2p-primscrn-spr-indfb-move
[262.731548] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[262.851292] [052/134] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[262.949617] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[262.953840] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[263.073970] [053/134] (758s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[268.111858] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[268.115924] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[268.943405] [054/134] (752s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[269.009586] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[269.113961] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s)
[269.205381] [055/134] (752s left) gem_mmap_wc (bad-size)
[269.267837] Subtest bad-size: SKIP (0.000s)
[269.328855] [056/134] (752s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[269.431403] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[269.435868] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[269.566893] [057/134] (752s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[269.669809] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[269.673997] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[269.777120] [058/134] (752s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[269.906378] Starting subtest: cursorA-vs-flipB-atomic
[269.911208] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[270.077720] [059/134] (752s left) sysfs_heartbeat_interval (nopreempt)
[270.139458] Starting subtest: nopreempt
[270.141400] Starting dynamic subtest: vecs0
[279.918772] Dynamic subtest vecs0: SUCCESS (9.774s)
[279.929645] Starting dynamic subtest: ccs0
[283.960035] Dynamic subtest ccs0: SUCCESS (4.041s)
[283.971062] Starting dynamic subtest: vcs0
[293.918314] Dynamic subtest vcs0: SUCCESS (9.954s)
[293.929230] Starting dynamic subtest: bcs0
[297.881923] Dynamic subtest bcs0: SUCCESS (3.964s)
[297.893070] Starting dynamic subtest: rcs0
[301.995596] Dynamic subtest rcs0: SUCCESS (4.111s)
[302.006780] Starting dynamic subtest: vcs1
[311.914223] Dynamic subtest vcs1: SUCCESS (9.900s)
[311.918622] Subtest nopreempt: SUCCESS (41.758s)
[311.986012] [060/134] (710s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[312.090602] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[312.095095] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[312.216505] [061/134] (709s left) gem_wait (busy)
[312.287208] Starting subtest: busy
[312.289557] Starting dynamic subtest: all-engines
[313.879785] Dynamic subtest all-engines: SUCCESS (1.590s)
[313.891442] Starting dynamic subtest: rcs0
[314.420986] Dynamic subtest rcs0: SUCCESS (0.540s)
[314.432276] Starting dynamic subtest: bcs0
[314.962481] Dynamic subtest bcs0: SUCCESS (0.540s)
[314.972933] Starting dynamic subtest: vcs0
[316.885258] Dynamic subtest vcs0: SUCCESS (1.920s)
[316.896720] Starting dynamic subtest: vcs1
[318.933064] Dynamic subtest vcs1: SUCCESS (2.045s)
[318.944238] Starting dynamic subtest: vecs0
[320.918516] Dynamic subtest vecs0: SUCCESS (1.983s)
[320.930399] Starting dynamic subtest: ccs0
[321.460302] Dynamic subtest ccs0: SUCCESS (0.541s)
[321.462829] Subtest busy: SUCCESS (9.173s)
[321.679435] [062/134] (700s left) kms_setmode (clone-exclusive-crtc)
[321.756751] Starting subtest: clone-exclusive-crtc
[321.763952] Subtest clone-exclusive-crtc: SKIP (0.000s)
[321.897186] [063/134] (700s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[327.000889] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[327.005507] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[327.885701] [064/134] (694s left) sw_sync (sync_merge_same)
[327.931089] Starting subtest: sync_merge_same
[327.933375] Subtest sync_merge_same: SUCCESS (0.000s)
[328.022240] [065/134] (694s left) kms_hdr (static-toggle)
[328.114323] Starting subtest: static-toggle
[328.121415] Subtest static-toggle: SKIP (0.000s)
[328.204546] [066/134] (694s left) gem_exec_await (wide-contexts)
[328.425965] Starting subtest: wide-contexts
[351.656225] Subtest wide-contexts: SUCCESS (23.232s)
[351.862925] [067/134] (670s left) kms_invalid_mode (uint-max-clock)
[352.008131] Starting subtest: uint-max-clock
[352.010448] Starting dynamic subtest: pipe-A-eDP-1
[352.296591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[352.306179] Starting dynamic subtest: pipe-B-eDP-1
[352.308661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[352.327436] Starting dynamic subtest: pipe-C-eDP-1
[352.329950] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[352.341161] Starting dynamic subtest: pipe-D-eDP-1
[352.343379] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[352.345754] Subtest uint-max-clock: SUCCESS (0.293s)
[353.092607] [068/134] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[353.189322] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[356.922626] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.737s)
[358.123340] [069/134] (664s left) kms_pm_rpm (modeset-non-lpsp)
[360.086334] Starting subtest: modeset-non-lpsp
[361.244576] Subtest modeset-non-lpsp: SKIP (1.157s)
[361.644898] [070/134] (660s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[361.749141] Starting subtest: fbc-pr-cursor-mmap-cpu
[361.753147] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[361.845873] [071/134] (660s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[361.952645] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[366.053820] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.106s)
[367.232438] [072/134] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[367.337801] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[367.342033] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[367.459303] [073/134] (655s left) i915_pm_rps (thresholds-idle)
[367.521411] Starting subtest: thresholds-idle
[367.525975] Subtest thresholds-idle: SKIP (0.001s)
[367.639025] [074/134] (655s left) kms_vblank (query-idle-hang)
[367.735545] Starting subtest: query-idle-hang
[367.737936] Starting dynamic subtest: pipe-A-eDP-1
[394.711242] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.972s)
[394.725725] Starting dynamic subtest: pipe-D-eDP-1
[409.693659] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.981s)
[409.696062] Subtest query-idle-hang: SUCCESS (41.957s)
[410.578139] [075/134] (612s left) perf_pmu (most-busy-idle-check-all)
[410.618822] Starting subtest: most-busy-idle-check-all
[410.621082] Starting dynamic subtest: rcs0
[411.926934] Dynamic subtest rcs0: SUCCESS (1.307s)
[411.938865] Starting dynamic subtest: bcs0
[413.910638] Dynamic subtest bcs0: SUCCESS (1.980s)
[413.922952] Starting dynamic subtest: vcs0
[415.894396] Dynamic subtest vcs0: SUCCESS (1.980s)
[415.906809] Starting dynamic subtest: vcs1
[417.878680] Dynamic subtest vcs1: SUCCESS (1.981s)
[417.890102] Starting dynamic subtest: vecs0
[419.926458] Dynamic subtest vecs0: SUCCESS (2.045s)
[419.938617] Starting dynamic subtest: ccs0
[421.910570] Dynamic subtest ccs0: SUCCESS (1.981s)
[421.913140] Subtest most-busy-idle-check-all: SUCCESS (11.292s)
[422.029764] [076/134] (600s left) kms_atomic_interruptible (universal-setplane-cursor)
[422.160314] Starting subtest: universal-setplane-cursor
[422.162590] Starting dynamic subtest: pipe-A-eDP-1
[429.569873] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.407s)
[429.572244] Subtest universal-setplane-cursor: SUCCESS (7.409s)
[430.425282] [077/134] (592s left) gem_userptr_blits (process-exit-busy)
[430.506739] Starting subtest: process-exit-busy
[430.516188] Subtest process-exit-busy: SUCCESS (0.012s)
[430.690814] [078/134] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[430.798972] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[430.803154] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[430.921044] [079/134] (592s left) gem_lmem_swapping (heavy-verify-multi)
[430.969009] Subtest heavy-verify-multi: SKIP (0.000s)
[431.015503] [080/134] (591s left) gen9_exec_parse (bb-start-cmd)
[431.079946] Subtest bb-start-cmd: SKIP (0.000s)
[431.138774] [081/134] (591s left) fbdev (unaligned-read)
[431.185293] Starting subtest: unaligned-read
[431.197357] Subtest unaligned-read: SUCCESS (0.015s)
[431.262534] [082/134] (591s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[431.646053] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[432.428965] [083/134] (590s left) gem_ppgtt (blt-vs-render-ctx0)
[432.499694] Starting subtest: blt-vs-render-ctx0
[465.306691] Subtest blt-vs-render-ctx0: SUCCESS (32.803s)
[465.462037] [084/134] (557s left) core_setmaster_vs_auth
[465.662143] [085/134] (557s left) prime_busy (hang)
[465.729356] Starting subtest: hang
[465.731595] Starting dynamic subtest: rcs0
[491.441090] Dynamic subtest rcs0: SUCCESS (25.706s)
[491.451528] Starting dynamic subtest: bcs0
[498.594230] Dynamic subtest bcs0: SUCCESS (7.151s)
[498.604587] Starting dynamic subtest: vcs0
[505.572222] Dynamic subtest vcs0: SUCCESS (6.976s)
[505.586653] Starting dynamic subtest: vcs1
[512.544103] Dynamic subtest vcs1: SUCCESS (6.973s)
[512.555650] Starting dynamic subtest: vecs0
[519.581999] Dynamic subtest vecs0: SUCCESS (7.037s)
[519.593861] Starting dynamic subtest: ccs0
[533.421435] Dynamic subtest ccs0: SUCCESS (13.837s)
[533.423795] Subtest hang: SUCCESS (67.688s)
[533.576645] [086/134] (489s left) gem_eio (unwedge-stress)
[533.765896] Starting subtest: unwedge-stress
[533.768459] Starting dynamic subtest: render
[538.222216] Dynamic subtest render: SUCCESS (4.452s)
[538.238340] Starting dynamic subtest: bsd1
[556.342889] Dynamic subtest bsd1: SUCCESS (18.120s)
[556.357193] Starting dynamic subtest: bsd2
[574.362084] Dynamic subtest bsd2: SUCCESS (18.017s)
[574.378332] Starting dynamic subtest: blt
[574.382561] Dynamic subtest blt: SKIP (0.000s)
[574.391395] Starting dynamic subtest: vebox
[592.373842] Dynamic subtest vebox: SUCCESS (18.008s)
[592.376211] Subtest unwedge-stress: SUCCESS (58.603s)
[594.011174] [087/134] (429s left) kms_cursor_crc (cursor-random-256x256)
[594.289923] Starting subtest: cursor-random-256x256
[594.292222] Starting dynamic subtest: pipe-A-eDP-1
[597.664164] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.372s)
[597.695020] Starting dynamic subtest: pipe-D-eDP-1
[601.644202] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.954s)
[601.646312] Subtest cursor-random-256x256: SUCCESS (7.354s)
[602.523647] [088/134] (420s left) syncobj_timeline (multi-wait-submitted-signaled)
[602.593397] Starting subtest: multi-wait-submitted-signaled
[602.595662] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[602.723283] [089/134] (420s left) kms_dsc (dsc-with-formats)
[602.822280] Starting subtest: dsc-with-formats
[602.860761] Subtest dsc-with-formats: SKIP (0.001s)
[602.909162] [090/134] (420s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[603.012806] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[609.666202] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.654s)
[609.824579] [091/134] (413s left) api_intel_allocator (reopen-fork)
[609.880511] Starting subtest: reopen-fork
[613.266872] Subtest reopen-fork: SUCCESS (3.385s)
[613.360148] [092/134] (410s left) gem_exec_whisper (basic-fds-priority-all)
[613.416161] Starting subtest: basic-fds-priority-all
[637.054874] Subtest basic-fds-priority-all: SUCCESS (23.633s)
[637.249410] [093/134] (386s left) gem_exec_fence (basic-wait-all)
[637.320826] Starting subtest: basic-wait-all
[637.447146] Subtest basic-wait-all: SUCCESS (0.127s)
[639.072762] [094/134] (384s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[639.180067] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[639.182406] Starting dynamic subtest: pipe-A-eDP-1
[639.240759] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[639.249434] Starting dynamic subtest: pipe-B-eDP-1
[639.305648] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[639.315623] Starting dynamic subtest: pipe-C-eDP-1
[639.369140] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[639.377742] Starting dynamic subtest: pipe-D-eDP-1
[639.431891] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[639.435990] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[641.494070] [095/134] (382s left) kms_psr (fbc-psr2-no-drrs)
[641.583847] Starting subtest: fbc-psr2-no-drrs
[641.586101] Starting dynamic subtest: eDP-1
[641.590320] Dynamic subtest eDP-1: SKIP (0.000s)
[641.594603] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[641.669363] [096/134] (381s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[641.762549] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[641.766668] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[641.888612] [097/134] (381s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[641.978976] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[641.983277] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[642.097903] [098/134] (381s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[642.202220] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[645.849838] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.651s)
[647.006941] [099/134] (376s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[647.103689] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[647.105978] Starting dynamic subtest: pipe-A
[647.128271] Dynamic subtest pipe-A: SKIP (0.019s)
[647.137992] Starting dynamic subtest: pipe-B
[647.161778] Dynamic subtest pipe-B: SKIP (0.033s)
[647.171116] Starting dynamic subtest: pipe-C
[647.194789] Dynamic subtest pipe-C: SKIP (0.033s)
[647.204085] Starting dynamic subtest: pipe-D
[647.227165] Dynamic subtest pipe-D: SKIP (0.032s)
[647.230954] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.119s)
[647.364258] [100/134] (376s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[647.464849] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[647.469227] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[647.561515] [101/134] (376s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[647.695750] Starting subtest: flip-vs-cursor-busy-crc-atomic
[648.510748] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s)
[649.323448] [102/134] (374s left) core_getstats (basic)
[649.387606] Starting subtest: basic
[649.389940] Subtest basic: SUCCESS (0.000s)
[649.514142] [103/134] (374s left) gem_mmap_gtt (hang-busy)
[649.586430] Subtest hang-busy: SKIP (0.000s)
[649.653347] [104/134] (374s left) kms_flip (flip-vs-expired-vblank-interruptible)
[649.752618] Starting subtest: flip-vs-expired-vblank-interruptible
[649.754933] Starting dynamic subtest: A-eDP1
[658.422383] Dynamic subtest A-eDP1: SUCCESS (8.668s)
[658.433270] Starting dynamic subtest: B-eDP1
[667.055905] Dynamic subtest B-eDP1: SUCCESS (8.631s)
[667.067936] Starting dynamic subtest: C-eDP1
[675.678110] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[675.691288] Starting dynamic subtest: D-eDP1
[684.319209] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[684.324402] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.571s)
[685.496091] [105/134] (338s left) gem_exec_schedule (preempt-queue-contexts)
[685.575430] Subtest preempt-queue-contexts: SKIP (0.000s)
[685.879962] [106/134] (338s left) perf (oa-formats)
[685.987276] Starting subtest: oa-formats
[685.989671] Starting dynamic subtest: 0-rcs0
[686.004081] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[686.013317] Starting dynamic subtest: 1-vecs0
[686.025676] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[686.028050] Subtest oa-formats: SUCCESS (0.040s)
[686.066059] [107/134] (338s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[686.180049] Starting subtest: fbcpsr-modesetfrombusy
[692.460281] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.285s)
[692.625027] [108/134] (331s left) kms_flip (2x-dpms-vs-vblank-race)
[692.725600] Starting subtest: 2x-dpms-vs-vblank-race
[692.737063] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[692.830364] [109/134] (331s left) gem_exec_params (readonly)
[692.888218] Starting subtest: readonly
[692.890256] Subtest readonly: SUCCESS (0.003s)
[693.034303] [110/134] (331s left) kms_vblank (invalid)
[693.138101] Starting subtest: invalid
[693.139852] Starting dynamic subtest: pipe-A-eDP-1
[693.533889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.395s)
[693.536158] Subtest invalid: SUCCESS (0.397s)
[694.377858] [111/134] (329s left) gem_exec_reloc (basic-cpu-read-noreloc)
[694.532025] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[694.598030] [112/134] (329s left) gem_ctx_persistence (engines-hostile)
[694.656497] Starting subtest: engines-hostile
[694.658924] Starting dynamic subtest: rcs0
[694.703577] Dynamic subtest rcs0: SUCCESS (0.047s)
[694.714328] Starting dynamic subtest: bcs0
[694.824658] Dynamic subtest bcs0: SUCCESS (0.120s)
[694.836050] Starting dynamic subtest: vcs0
[694.979841] Dynamic subtest vcs0: SUCCESS (0.153s)
[694.991864] Starting dynamic subtest: vcs1
[695.088196] Dynamic subtest vcs1: SUCCESS (0.107s)
[695.099466] Starting dynamic subtest: vecs0
[695.168379] Dynamic subtest vecs0: SUCCESS (0.078s)
[695.178927] Starting dynamic subtest: ccs0
[695.332794] Dynamic subtest ccs0: SUCCESS (0.162s)
[695.335268] Subtest engines-hostile: SUCCESS (0.678s)
[695.438141] [113/134] (328s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[695.546091] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[695.549478] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[695.675269] [114/134] (328s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[695.775333] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[695.778632] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[695.894112] [115/134] (328s left) gem_caching (writes)
[695.956735] Subtest writes: SKIP (0.000s)
[696.033646] [116/134] (328s left) kms_pm_backlight (fade-with-suspend)
[696.115976] Starting subtest: fade-with-suspend
[711.983910] Starting dynamic subtest: eDP-1
[714.682658] Dynamic subtest eDP-1: SUCCESS (2.653s)
[714.684855] Subtest fade-with-suspend: SUCCESS (4.002s)
[715.572353] [117/134] (308s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[715.699206] Starting subtest: coverage-vs-premult-vs-constant
[716.037726] Starting dynamic subtest: pipe-A-eDP-1
[716.622336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[716.635129] Starting dynamic subtest: pipe-D-eDP-1
[717.918443] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.276s)
[717.920784] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.186s)
[718.783765] [118/134] (305s left) kms_lease (master-vs-lease)
[718.886070] Starting subtest: master-vs-lease
[718.888442] Subtest master-vs-lease: SUCCESS (0.002s)
[719.038601] [119/134] (305s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[719.142283] Starting subtest: psr-rgb565-draw-mmap-wc
[725.986016] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.795s)
[726.124096] [120/134] (298s left) kms_addfb_basic (addfb25-4-tiled)
[726.223251] Starting subtest: addfb25-4-tiled
[726.225116] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[726.346032] [121/134] (298s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[726.433361] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[726.437297] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[726.527373] [122/134] (298s left) kms_plane_multiple (2x-tiling-x)
[726.618131] Starting subtest: 2x-tiling-x
[726.622172] Subtest 2x-tiling-x: SKIP (0.000s)
[726.710005] [123/134] (298s left) kms_psr (psr2-primary-render)
[726.797631] Starting subtest: psr2-primary-render
[726.799950] Starting dynamic subtest: eDP-1
[728.560907] Dynamic subtest eDP-1: SUCCESS (1.756s)
[728.563214] Subtest psr2-primary-render: SUCCESS (1.757s)
[729.443095] [124/134] (295s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[729.512312] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[729.619185] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[729.711598] [125/134] (295s left) gem_exec_balancer (full)
[729.780330] Starting subtest: full
[734.306590] Subtest full: SUCCESS (4.514s)
[734.650904] [126/134] (290s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[734.751693] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[734.755672] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[734.881187] [127/134] (290s left) gem_mmap_wc (write-read)
[734.951663] Subtest write-read: SKIP (0.000s)
[735.020198] [128/134] (289s left) gem_ctx_persistence (process)
[735.085155] Starting subtest: process
[735.305607] Subtest process: SUCCESS (0.219s)
[735.398442] [129/134] (289s left) gem_ctx_param (non-root-set)
[735.457033] Starting subtest: non-root-set
[735.486164] Subtest non-root-set: SUCCESS (0.029s)
[735.602989] [130/134] (289s left) sw_sync (timeline_closed)
[735.637962] Starting subtest: timeline_closed
[735.639958] Subtest timeline_closed: SUCCESS (0.000s)
[735.709972] [131/134] (289s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[735.811173] Starting subtest: primary-4-tiled-reflect-x-180
[742.867443] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.049s)
[744.122185] [132/134] (281s left) gem_exec_parallel (basic)
[744.197898] Starting subtest: basic
[744.200324] Starting dynamic subtest: rcs0
[745.648170] Dynamic subtest rcs0: SUCCESS (1.450s)
[745.659110] Starting dynamic subtest: bcs0
[747.147551] Dynamic subtest bcs0: SUCCESS (1.497s)
[747.157744] Starting dynamic subtest: vcs0
[750.406165] Dynamic subtest vcs0: SUCCESS (3.255s)
[750.419066] Starting dynamic subtest: vcs1
[752.390672] Dynamic subtest vcs1: SUCCESS (1.981s)
[752.403735] Starting dynamic subtest: vecs0
[754.373962] Dynamic subtest vecs0: SUCCESS (1.981s)
[754.386480] Starting dynamic subtest: ccs0
[755.852656] Dynamic subtest ccs0: SUCCESS (1.477s)
[755.854835] Subtest basic: SUCCESS (11.655s)
[756.048937] [133/134] (269s left) kms_content_protection (uevent-hdcp14)
[756.195960] Starting subtest: uevent-hdcp14
[756.200564] Subtest uevent-hdcp14: SKIP (0.000s)
[756.339930] [134/134] (268s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[756.393222] Starting subtest: multi-wait-all-for-submit-available-signaled
[756.395440] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[756.508720] 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.