[58.987947] Initializing watchdogs
[58.987998]   /dev/watchdog0
[59.003829] [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.008832] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.011398] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.014759] [001/132] (960s left) vgem_basic (dmabuf-fence)
[59.115750] Starting subtest: dmabuf-fence
[59.117838] Subtest dmabuf-fence: SUCCESS (0.001s)
[59.171245] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[59.174386] [002/132] (960s left) kms_content_protection (atomic-dpms-hdcp14)
[59.323753] Starting subtest: atomic-dpms-hdcp14
[59.328699] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[59.470932] [003/132] (960s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[59.581805] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[64.097269] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.581s)
[65.293441] [004/132] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[65.403175] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[72.913036] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.553s)
[73.166615] [005/132] (946s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[73.535711] Starting subtest: cursor-rapid-movement-max-size
[73.542493] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[73.743304] [006/132] (945s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[73.845297] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[73.849939] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[73.930182] [007/132] (945s left) gem_mmap_gtt (basic-small-copy-odd)
[73.993496] Subtest basic-small-copy-odd: SKIP (0.000s)
[74.052047] [008/132] (945s left) gem_pxp (create-regular-buffer)
[74.167641] Starting subtest: create-regular-buffer
[74.170069] Subtest create-regular-buffer: SUCCESS (0.000s)
[74.272531] [009/132] (945s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[74.379792] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[74.383885] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[74.473753] [010/132] (945s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[74.571046] Starting subtest: fbc-psr2-cursor-mmap-cpu
[74.573256] Starting dynamic subtest: eDP-1
[74.577690] Dynamic subtest eDP-1: SKIP (0.000s)
[74.582290] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[74.641990] [011/132] (945s left) gem_exec_balancer (parallel-balancer)
[74.907441] Starting subtest: parallel-balancer
[75.848396] Subtest parallel-balancer: SUCCESS (0.945s)
[75.942825] [012/132] (944s left) gen9_exec_parse (secure-batches)
[76.008471] Subtest secure-batches: SKIP (0.000s)
[76.079118] [013/132] (943s left) kms_addfb_basic (tile-pitch-mismatch)
[76.132208] Starting subtest: tile-pitch-mismatch
[76.136650] Subtest tile-pitch-mismatch: SKIP (0.000s)
[76.279733] [014/132] (943s left) gem_exec_params (invalid-batch-start-offset)
[76.325741] Starting subtest: invalid-batch-start-offset
[76.328077] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[76.432918] [015/132] (943s left) perf_pmu (busy-accuracy-98)
[76.473589] Starting subtest: busy-accuracy-98
[76.475672] Starting dynamic subtest: rcs0
[79.511618] Dynamic subtest rcs0: SUCCESS (3.042s)
[79.522761] Starting dynamic subtest: bcs0
[82.563136] Dynamic subtest bcs0: SUCCESS (3.053s)
[82.574015] Starting dynamic subtest: vcs0
[85.605310] Dynamic subtest vcs0: SUCCESS (3.043s)
[85.615840] Starting dynamic subtest: vcs1
[88.644708] Dynamic subtest vcs1: SUCCESS (3.038s)
[88.655956] Starting dynamic subtest: vecs0
[91.682738] Dynamic subtest vecs0: SUCCESS (3.035s)
[91.693295] Starting dynamic subtest: ccs0
[94.734666] Dynamic subtest ccs0: SUCCESS (3.050s)
[94.736937] Subtest busy-accuracy-98: SUCCESS (18.268s)
[94.849282] [016/132] (925s left) kms_color (degamma)
[94.954646] Starting subtest: degamma
[94.956573] Starting dynamic subtest: pipe-A-eDP-1
[95.706100] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s)
[95.716370] Starting dynamic subtest: pipe-B-eDP-1
[97.112780] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.405s)
[97.122490] Starting dynamic subtest: pipe-C-eDP-1
[98.498590] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[98.508408] Starting dynamic subtest: pipe-D-eDP-1
[99.931612] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.432s)
[99.933660] Subtest degamma: SUCCESS (4.975s)
[100.735154] [017/132] (919s left) perf_pmu (invalid-init)
[100.776769] Starting subtest: invalid-init
[100.779057] Subtest invalid-init: SUCCESS (0.000s)
[100.896835] [018/132] (919s left) kms_draw_crc (draw-method-blt)
[100.995054] Starting subtest: draw-method-blt
[100.997432] Starting dynamic subtest: xrgb8888-untiled
[101.258610] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[101.268228] Starting dynamic subtest: rgb565-untiled
[101.492422] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[101.502406] Starting dynamic subtest: xrgb2101010-untiled
[101.713845] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[101.723204] Starting dynamic subtest: xbgr16161616f-untiled
[101.936200] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[101.946577] Starting dynamic subtest: xrgb8888-xtiled
[102.058269] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[102.069099] Starting dynamic subtest: rgb565-xtiled
[102.181126] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[102.190876] Starting dynamic subtest: xrgb2101010-xtiled
[102.291881] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[102.303984] Starting dynamic subtest: xbgr16161616f-xtiled
[102.402762] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[102.411782] Starting dynamic subtest: xrgb8888-4tiled
[102.525060] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[102.533862] Starting dynamic subtest: rgb565-4tiled
[102.647637] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[102.656545] Starting dynamic subtest: xrgb2101010-4tiled
[102.758246] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[102.767486] Starting dynamic subtest: xbgr16161616f-4tiled
[102.869783] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s)
[102.871732] Subtest draw-method-blt: SUCCESS (1.878s)
[103.008410] [019/132] (917s left) syncobj_timeline (wait-all-for-submit-complex)
[103.066833] Starting subtest: wait-all-for-submit-complex
[103.283442] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[103.361582] [020/132] (916s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[103.470496] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[103.474690] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[103.578759] [021/132] (916s left) kms_vblank (wait-busy-hang)
[103.676077] Starting subtest: wait-busy-hang
[103.677969] Starting dynamic subtest: pipe-A-eDP-1
[130.121878] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.442s)
[130.135447] Starting dynamic subtest: pipe-D-eDP-1
[155.081759] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.958s)
[155.084125] Subtest wait-busy-hang: SUCCESS (51.405s)
[155.916386] [022/132] (864s left) perf (invalid-oa-format-id)
[156.049982] Starting subtest: invalid-oa-format-id
[156.061962] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[156.104416] [023/132] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[156.207486] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[163.084787] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.880s)
[163.223693] [024/132] (857s left) sw_sync (alloc_merge_fence)
[163.258814] Starting subtest: alloc_merge_fence
[163.261085] Subtest alloc_merge_fence: SUCCESS (0.000s)
[163.307303] [025/132] (857s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[163.405421] Starting subtest: fbcpsr-tiling-4
[170.605747] Subtest fbcpsr-tiling-4: SUCCESS (7.202s)
[170.752149] [026/132] (849s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[170.811359] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[170.917318] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[170.993214] [027/132] (849s left) kms_flip (2x-plain-flip-fb-recreate)
[171.082405] Starting subtest: 2x-plain-flip-fb-recreate
[171.094116] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[171.174210] [028/132] (849s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[171.277673] Starting subtest: yf-tiled-32bpp-rotate-0
[171.282208] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[171.382585] [029/132] (849s left) syncobj_timeline (multi-wait-for-submit-signaled)
[171.437022] Starting subtest: multi-wait-for-submit-signaled
[171.439262] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[171.551355] [030/132] (849s left) gem_render_copy_redux (flink-interruptible)
[171.610782] Starting subtest: flink-interruptible
[172.344715] Subtest flink-interruptible: SUCCESS (0.735s)
[172.427296] [031/132] (848s left) syncobj_wait (wait-for-submit-snapshot)
[172.473750] Starting subtest: wait-for-submit-snapshot
[172.554034] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[172.642959] [032/132] (848s left) gem_exec_params (secure-non-root)
[172.699475] Starting subtest: secure-non-root
[172.703490] Subtest secure-non-root: SKIP (0.000s)
[172.795897] [033/132] (848s left) gem_mmap_gtt (close-race)
[172.859773] Subtest close-race: SKIP (0.000s)
[172.916829] [034/132] (847s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[172.972391] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[173.076827] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[173.166300] [035/132] (847s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[173.273577] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[173.277665] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[173.366134] [036/132] (847s left) gem_reg_read (bad-register)
[173.427194] Starting subtest: bad-register
[173.429593] Subtest bad-register: SUCCESS (0.000s)
[173.524242] [037/132] (847s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[173.618253] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[180.279222] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.664s)
[180.395319] [038/132] (840s left) perf (invalid-open-flags)
[180.496437] Starting subtest: invalid-open-flags
[180.498871] Subtest invalid-open-flags: SUCCESS (0.000s)
[180.539031] [039/132] (840s left) kms_debugfs (display-on-read-all)
[180.647953] Starting subtest: display-on-read-all
[180.836528] Subtest display-on-read-all: SUCCESS (0.189s)
[180.971244] [040/132] (840s left) kms_lease (lessee-list)
[181.065063] Starting subtest: lessee-list
[181.067368] Starting dynamic subtest: pipe-A-eDP-1
[181.069599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[181.079076] Starting dynamic subtest: pipe-B-eDP-1
[181.081199] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[181.090236] Starting dynamic subtest: pipe-C-eDP-1
[181.092360] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[181.101246] Starting dynamic subtest: pipe-D-eDP-1
[181.103375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[181.105461] Subtest lessee-list: SUCCESS (0.008s)
[181.182282] [041/132] (839s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[181.273930] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[181.277918] Starting dynamic subtest: pipe-A
[181.298659] Dynamic subtest pipe-A: SKIP (0.020s)
[181.308043] Starting dynamic subtest: pipe-B
[181.334502] Dynamic subtest pipe-B: SKIP (0.034s)
[181.345713] Starting dynamic subtest: pipe-C
[181.368070] Dynamic subtest pipe-C: SKIP (0.034s)
[181.376890] Starting dynamic subtest: pipe-D
[181.400862] Dynamic subtest pipe-D: SKIP (0.034s)
[181.404068] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.124s)
[181.506192] [042/132] (839s left) kms_psr (pr-sprite-render)
[181.597096] Starting subtest: pr-sprite-render
[181.600698] Subtest pr-sprite-render: SKIP (0.000s)
[181.667174] [043/132] (839s left) gem_exec_fence (submit)
[181.841245] Starting subtest: submit
[181.845826] Subtest submit: SKIP (0.000s)
[183.380310] [044/132] (837s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[183.485361] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[183.489463] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[183.568427] [045/132] (837s left) gem_spin_batch (resubmit-new)
[183.631775] Starting subtest: resubmit-new
[183.634288] Starting dynamic subtest: rcs0
[183.642196] Dynamic subtest rcs0: SUCCESS (0.010s)
[183.651752] Starting dynamic subtest: bcs0
[183.653630] Dynamic subtest bcs0: SUCCESS (0.006s)
[183.662889] Starting dynamic subtest: vcs0
[183.665102] Dynamic subtest vcs0: SUCCESS (0.006s)
[183.674640] Starting dynamic subtest: vcs1
[183.676537] Dynamic subtest vcs1: SUCCESS (0.005s)
[183.685439] Starting dynamic subtest: vecs0
[183.687348] Dynamic subtest vecs0: SUCCESS (0.005s)
[183.696068] Starting dynamic subtest: ccs0
[183.697940] Dynamic subtest ccs0: SUCCESS (0.004s)
[183.699869] Subtest resubmit-new: SUCCESS (0.040s)
[185.322377] [046/132] (836s left) kms_flip (2x-busy-flip)
[185.424157] Starting subtest: 2x-busy-flip
[185.436051] Subtest 2x-busy-flip: SKIP (0.014s)
[185.530473] [047/132] (835s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[185.626059] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[185.630236] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[185.705388] [048/132] (835s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[186.101272] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[186.930806] [049/132] (834s left) kms_vblank (accuracy-idle)
[187.033445] Starting subtest: accuracy-idle
[187.035655] Starting dynamic subtest: pipe-A-eDP-1
[188.800823] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.769s)
[188.815811] Starting dynamic subtest: pipe-D-eDP-1
[191.301804] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.497s)
[191.304240] Subtest accuracy-idle: SUCCESS (4.270s)
[192.121111] [050/132] (829s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[192.218314] Starting subtest: plane-downscale-factor-0-5-with-rotation
[192.220650] Starting dynamic subtest: pipe-A
[192.241408] Dynamic subtest pipe-A: SKIP (0.018s)
[192.252679] Starting dynamic subtest: pipe-B
[192.275803] Dynamic subtest pipe-B: SKIP (0.034s)
[192.288328] Starting dynamic subtest: pipe-C
[192.308586] Dynamic subtest pipe-C: SKIP (0.033s)
[192.317996] Starting dynamic subtest: pipe-D
[192.342641] Dynamic subtest pipe-D: SKIP (0.034s)
[192.346487] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.121s)
[192.440783] [051/132] (829s left) gem_exec_params (invalid-flag)
[192.501521] Starting subtest: invalid-flag
[192.503877] Subtest invalid-flag: SUCCESS (0.000s)
[192.598760] [052/132] (829s left) kms_getfb (getfb2-into-addfb2)
[192.690970] Starting subtest: getfb2-into-addfb2
[192.693284] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[192.809190] [053/132] (828s left) kms_cursor_crc (cursor-offscreen-max-size)
[193.129705] Starting subtest: cursor-offscreen-max-size
[193.135470] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[193.290979] [054/132] (828s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[193.393608] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[194.051413] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[194.226895] [055/132] (827s left) gem_userptr_blits (map-fixed-invalidate)
[194.286723] Starting subtest: map-fixed-invalidate
[194.291252] Subtest map-fixed-invalidate: SKIP (0.000s)
[194.411522] [056/132] (827s left) prime_self_import (basic-llseek-bad)
[194.444502] Starting subtest: basic-llseek-bad
[194.458461] Subtest basic-llseek-bad: SUCCESS (0.014s)
[194.558242] [057/132] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[194.658696] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[194.662748] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[194.764846] [058/132] (827s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[194.862088] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[194.864357] Starting dynamic subtest: pipe-A-eDP-1
[194.873574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[194.883273] Starting dynamic subtest: pipe-B-eDP-1
[194.892222] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[194.901243] Starting dynamic subtest: pipe-C-eDP-1
[194.909902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[194.919119] Starting dynamic subtest: pipe-D-eDP-1
[194.927768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[194.932169] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[197.198931] [059/132] (824s left) gem_exec_params (cliprects-invalid)
[197.250580] Starting subtest: cliprects-invalid
[197.252970] Subtest cliprects-invalid: SUCCESS (0.000s)
[197.343132] [060/132] (824s left) gem_mmap_gtt (hang-busy)
[197.393592] Subtest hang-busy: SKIP (0.000s)
[197.453899] [061/132] (824s left) kms_psr (psr-cursor-plane-onoff)
[197.542805] Starting subtest: psr-cursor-plane-onoff
[197.545083] Starting dynamic subtest: eDP-1
[199.307366] Dynamic subtest eDP-1: SUCCESS (1.764s)
[199.309650] Subtest psr-cursor-plane-onoff: SUCCESS (1.765s)
[200.165427] [062/132] (821s left) kms_joiner (invalid-modeset-big-joiner)
[200.273857] Starting subtest: invalid-modeset-big-joiner
[200.278123] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[200.351447] [063/132] (821s left) gem_exec_suspend (basic)
[200.415521] Starting subtest: basic
[200.417767] Starting dynamic subtest: smem
[202.304461] Dynamic subtest smem: SUCCESS (1.887s)
[202.307590] Subtest basic: SUCCESS (1.889s)
[202.489267] [064/132] (819s left) gem_ctx_persistence (engines-cleanup)
[202.546801] Starting subtest: engines-cleanup
[202.548981] Starting dynamic subtest: rcs0
[202.634799] Dynamic subtest rcs0: SUCCESS (0.090s)
[202.645995] Starting dynamic subtest: bcs0
[202.667556] Dynamic subtest bcs0: SUCCESS (0.031s)
[202.676893] Starting dynamic subtest: vcs0
[202.714706] Dynamic subtest vcs0: SUCCESS (0.045s)
[202.724954] Starting dynamic subtest: vcs1
[202.747461] Dynamic subtest vcs1: SUCCESS (0.031s)
[202.757061] Starting dynamic subtest: vecs0
[202.789285] Dynamic subtest vecs0: SUCCESS (0.040s)
[202.799093] Starting dynamic subtest: ccs0
[202.829863] Dynamic subtest ccs0: SUCCESS (0.039s)
[202.832461] Subtest engines-cleanup: SUCCESS (0.286s)
[202.910246] [065/132] (819s left) perf (non-system-wide-paranoid)
[203.009333] Starting subtest: non-system-wide-paranoid
[203.035058] Subtest non-system-wide-paranoid: SUCCESS (0.026s)
[203.088308] [066/132] (819s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[203.183230] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[209.831363] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.651s)
[209.956446] [067/132] (812s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[210.058389] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[210.062483] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[210.153627] [068/132] (812s left) perf (invalid-oa-exponent)
[210.237683] Starting subtest: invalid-oa-exponent
[210.249592] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[210.297875] [069/132] (812s left) gen7_exec_parse (basic-allocation)
[210.356333] Subtest basic-allocation: SKIP (0.000s)
[210.433170] [070/132] (811s left) kms_cursor_edge_walk (64x64-top-bottom)
[210.519231] Starting subtest: 64x64-top-bottom
[210.521449] Starting dynamic subtest: pipe-A-eDP-1
[213.965481] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[213.975869] Starting dynamic subtest: pipe-D-eDP-1
[217.179038] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.213s)
[217.181170] Subtest 64x64-top-bottom: SUCCESS (6.662s)
[218.004298] [071/132] (804s left) gem_busy (semaphore)
[218.197589] Subtest semaphore: SKIP (0.000s)
[218.417212] [072/132] (804s left) i915_module_load (resize-bar)
[218.458679] Starting subtest: resize-bar
[218.465417] Subtest resize-bar: SKIP (0.007s)
[218.505943] [073/132] (803s left) gem_create (create-ext-cpu-access-sanity-check)
[218.678067] Starting subtest: create-ext-cpu-access-sanity-check
[218.682829] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[218.748374] [074/132] (803s left) gem_pxp (verify-pxp-stale-ctx-execution)
[218.806696] Starting subtest: verify-pxp-stale-ctx-execution
[219.868622] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.059s)
[220.005702] [075/132] (802s left) kms_chamelium_hpd (vga-hpd)
[220.380065] Subtest vga-hpd: SKIP (0.000s)
[221.204167] [076/132] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[221.302685] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[221.307086] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[221.404824] [077/132] (801s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[221.529571] Starting subtest: flip-vs-cursor-atomic
[229.048477] Subtest flip-vs-cursor-atomic: SUCCESS (7.515s)
[229.893908] [078/132] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[229.989867] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[229.994283] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[230.092130] [079/132] (792s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[230.192932] Starting subtest: primary-yf-tiled-reflect-x-0
[230.263381] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[230.369358] [080/132] (792s left) gem_exec_whisper (basic-contexts-all)
[230.426494] Starting subtest: basic-contexts-all
[242.272435] Subtest basic-contexts-all: SUCCESS (11.843s)
[242.467503] [081/132] (780s left) kms_flip (plain-flip-ts-check-interruptible)
[242.568939] Starting subtest: plain-flip-ts-check-interruptible
[242.572169] Starting dynamic subtest: A-eDP1
[251.442493] Dynamic subtest A-eDP1: SUCCESS (8.872s)
[251.455225] Starting dynamic subtest: B-eDP1
[260.273046] Dynamic subtest B-eDP1: SUCCESS (8.829s)
[260.287792] Starting dynamic subtest: C-eDP1
[269.085775] Dynamic subtest C-eDP1: SUCCESS (8.810s)
[269.096687] Starting dynamic subtest: D-eDP1
[277.927832] Dynamic subtest D-eDP1: SUCCESS (8.843s)
[277.933041] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.363s)
[279.124146] [082/132] (743s left) device_reset (unbind-cold-reset-rebind)
[279.172085] Starting subtest: unbind-cold-reset-rebind
[279.176708] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[279.236345] [083/132] (743s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[279.326426] Starting subtest: crc-primary-basic-y-tiled-ccs
[279.328794] Starting dynamic subtest: pipe-A-eDP-1
[279.351443] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[279.362355] Starting dynamic subtest: pipe-B-eDP-1
[279.383782] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[279.393591] Starting dynamic subtest: pipe-C-eDP-1
[279.414793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[279.424040] Starting dynamic subtest: pipe-D-eDP-1
[279.446762] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[279.451121] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[281.601068] [084/132] (741s left) gem_exec_schedule (preemptive-hang)
[281.771074] Starting subtest: preemptive-hang
[281.773811] Starting dynamic subtest: rcs0
[291.434594] Dynamic subtest rcs0: SUCCESS (9.659s)
[291.444474] Starting dynamic subtest: bcs0
[300.394888] Dynamic subtest bcs0: SUCCESS (8.962s)
[300.405758] Starting dynamic subtest: vcs0
[309.419899] Dynamic subtest vcs0: SUCCESS (9.018s)
[309.429802] Starting dynamic subtest: vcs1
[318.442839] Dynamic subtest vcs1: SUCCESS (9.023s)
[318.452786] Starting dynamic subtest: vecs0
[327.399628] Dynamic subtest vecs0: SUCCESS (8.955s)
[327.409807] Starting dynamic subtest: ccs0
[336.425869] Dynamic subtest ccs0: SUCCESS (9.025s)
[336.428721] Subtest preemptive-hang: SUCCESS (54.652s)
[336.683723] [085/132] (686s left) gem_partial_pwrite_pread (reads)
[336.746081] Subtest reads: SKIP (0.000s)
[336.819999] [086/132] (686s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[336.920269] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[336.922537] Starting dynamic subtest: pipe-A-eDP-1
[336.947850] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[336.960088] Starting dynamic subtest: pipe-B-eDP-1
[336.984439] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[336.993679] Starting dynamic subtest: pipe-C-eDP-1
[337.017553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[337.027173] Starting dynamic subtest: pipe-D-eDP-1
[337.051895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[337.056055] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[339.245480] [087/132] (683s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[339.351486] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[339.353866] Starting dynamic subtest: pipe-A-default-mode
[342.088781] Dynamic subtest pipe-A-default-mode: SUCCESS (2.738s)
[342.091302] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.739s)
[342.936452] [088/132] (680s left) i915_pm_rpm (gem-pread)
[344.454493] Starting subtest: gem-pread
[346.876340] Subtest gem-pread: SUCCESS (2.420s)
[346.993966] [089/132] (676s left) gem_exec_capture (userptr)
[347.049988] Starting subtest: userptr
[347.874838] Subtest userptr: SUCCESS (0.823s)
[347.980649] [090/132] (675s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[348.079682] Starting subtest: pr-cursor-plane-move-continuous-sf
[348.084063] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[348.149552] [091/132] (675s left) kms_pm_rpm (modeset-lpsp)
[350.383758] Starting subtest: modeset-lpsp
[351.853821] Subtest modeset-lpsp: SUCCESS (1.473s)
[351.939942] [092/132] (671s left) gem_exec_schedule (u-semaphore-resolve)
[352.016138] Starting subtest: u-semaphore-resolve
[352.049475] Subtest u-semaphore-resolve: SUCCESS (0.041s)
[352.400911] [093/132] (670s left) gem_exec_params (no-bsd)
[352.446959] Starting subtest: no-bsd
[352.453085] Subtest no-bsd: SUCCESS (0.004s)
[354.385420] [094/132] (669s left) i915_drm_fdinfo (most-busy-idle-check-all)
[354.420849] Starting subtest: most-busy-idle-check-all
[354.423076] Starting dynamic subtest: rcs0
[354.430629] Dynamic subtest rcs0: SKIP (0.005s)
[354.441393] Starting dynamic subtest: bcs0
[354.445550] Dynamic subtest bcs0: SKIP (0.001s)
[354.455174] Starting dynamic subtest: vcs0
[354.459300] Dynamic subtest vcs0: SKIP (0.000s)
[354.468319] Starting dynamic subtest: vcs1
[354.472463] Dynamic subtest vcs1: SKIP (0.000s)
[354.481343] Starting dynamic subtest: vecs0
[354.485493] Dynamic subtest vecs0: SKIP (0.000s)
[354.494527] Starting dynamic subtest: ccs0
[354.499018] Dynamic subtest ccs0: SKIP (0.000s)
[354.503429] Subtest most-busy-idle-check-all: SKIP (0.012s)
[354.543527] [095/132] (668s left) gem_exec_params (sol-reset-invalid)
[354.620674] Starting subtest: sol-reset-invalid
[354.623078] Subtest sol-reset-invalid: SUCCESS (0.003s)
[356.369884] [096/132] (667s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[356.491712] Starting subtest: cursorB-vs-flipA-varying-size
[356.496523] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[356.638255] [097/132] (666s left) kms_async_flips (alternate-sync-async-flip-atomic)
[356.725307] Starting subtest: alternate-sync-async-flip-atomic
[357.106179] Starting dynamic subtest: pipe-A-eDP-1
[359.906663] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.802s)
[360.289065] Starting dynamic subtest: pipe-B-eDP-1
[363.046992] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[363.418568] Starting dynamic subtest: pipe-C-eDP-1
[366.172151] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s)
[366.554780] Starting dynamic subtest: pipe-D-eDP-1
[369.311644] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[369.313740] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.589s)
[370.486888] [098/132] (653s left) gem_ctx_persistence (heartbeat-hostile)
[370.542525] Starting subtest: heartbeat-hostile
[370.547069] Subtest heartbeat-hostile: SKIP (0.000s)
[370.642724] [099/132] (652s left) gem_softpin (32b-excludes-last-page)
[370.693894] Starting subtest: 32b-excludes-last-page
[370.698822] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[370.829556] [100/132] (652s left) gem_mmap_gtt (medium-copy-xy)
[370.876305] Subtest medium-copy-XY: SKIP (0.000s)
[370.945725] [101/132] (652s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[371.039154] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[371.041398] Starting dynamic subtest: pipe-A-eDP-1
[371.064826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[371.078090] Starting dynamic subtest: pipe-B-eDP-1
[371.099256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[371.108878] Starting dynamic subtest: pipe-C-eDP-1
[371.130565] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[371.140109] Starting dynamic subtest: pipe-D-eDP-1
[371.163500] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[371.167651] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[373.359435] [102/132] (650s left) prime_vgem (basic-fence-blt)
[373.435626] Starting subtest: basic-fence-blt
[373.530803] Subtest basic-fence-blt: SUCCESS (0.095s)
[373.653990] [103/132] (650s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[373.751610] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[373.755581] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[373.842670] [104/132] (649s left) kms_plane_multiple (2x-tiling-x)
[373.934189] Starting subtest: 2x-tiling-x
[373.938503] Subtest 2x-tiling-x: SKIP (0.000s)
[374.006677] [105/132] (649s left) gem_lmem_swapping (heavy-random)
[374.049616] Subtest heavy-random: SKIP (0.000s)
[374.092397] [106/132] (649s left) kms_psr (fbc-psr-cursor-render)
[374.185186] Starting subtest: fbc-psr-cursor-render
[374.187393] Starting dynamic subtest: eDP-1
[374.191380] Dynamic subtest eDP-1: SKIP (0.000s)
[374.195467] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[374.273531] [107/132] (649s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[376.399432] Starting subtest: dpms-mode-unset-lpsp
[380.484623] Subtest dpms-mode-unset-lpsp: SUCCESS (4.086s)
[380.872453] [108/132] (643s left) kms_fbcon_fbt (fbc-suspend)
[380.934822] Starting subtest: fbc-suspend
[430.535800] Subtest fbc-suspend: SUCCESS (20.150s)
[431.861893] [109/132] (592s left) gem_exec_fence (basic-wait)
[432.039186] Starting subtest: basic-wait
[432.041395] Starting dynamic subtest: rcs0
[432.118348] Dynamic subtest rcs0: SUCCESS (0.080s)
[432.131261] Starting dynamic subtest: bcs0
[432.172465] Dynamic subtest bcs0: SUCCESS (0.053s)
[432.185281] Starting dynamic subtest: vcs0
[432.226543] Dynamic subtest vcs0: SUCCESS (0.053s)
[432.241022] Starting dynamic subtest: vcs1
[432.281780] Dynamic subtest vcs1: SUCCESS (0.053s)
[432.294695] Starting dynamic subtest: vecs0
[432.335803] Dynamic subtest vecs0: SUCCESS (0.052s)
[432.348247] Starting dynamic subtest: ccs0
[432.393775] Dynamic subtest ccs0: SUCCESS (0.057s)
[432.396381] Subtest basic-wait: SUCCESS (0.363s)
[433.961052] [110/132] (590s left) kms_chamelium_color (ctm-max)
[434.054078] Subtest ctm-max: SKIP (0.000s)
[434.098982] [111/132] (590s left) gem_exec_reloc (basic-cpu-active)
[434.155775] Subtest basic-cpu-active: SKIP (0.000s)
[434.216279] [112/132] (589s left) gem_exec_suspend (basic-s3)
[434.287081] Starting subtest: basic-S3
[434.289494] Starting dynamic subtest: smem
[455.275498] Dynamic subtest smem: SUCCESS (6.677s)
[455.278525] Subtest basic-S3: SUCCESS (6.680s)
[455.459704] [113/132] (568s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[455.576241] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[455.580553] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[455.673249] [114/132] (568s left) gem_eio (context-create)
[455.901518] Starting subtest: context-create
[456.247183] Subtest context-create: SUCCESS (0.355s)
[456.359216] [115/132] (567s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[456.451392] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[456.453304] Starting dynamic subtest: pipe-A-eDP-1
[456.529893] Dynamic subtest pipe-A-eDP-1: SKIP (0.081s)
[456.542162] Starting dynamic subtest: pipe-B-eDP-1
[457.701601] Dynamic subtest pipe-B-eDP-1: SKIP (1.201s)
[457.706133] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.284s)
[458.960031] [116/132] (565s left) api_intel_bb (purge-bb)
[459.014659] Starting subtest: purge-bb
[459.017288] Subtest purge-bb: SUCCESS (0.004s)
[459.147789] [117/132] (565s left) kms_psr (psr-primary-page-flip)
[459.252762] Starting subtest: psr-primary-page-flip
[459.255002] Starting dynamic subtest: eDP-1
[461.042591] Dynamic subtest eDP-1: SUCCESS (1.822s)
[461.044855] Subtest psr-primary-page-flip: SUCCESS (1.824s)
[461.870945] [118/132] (562s left) sysfs_heartbeat_interval (precise)
[461.925114] Starting subtest: precise
[461.927213] Starting dynamic subtest: vecs0
[469.287703] Dynamic subtest vecs0: SUCCESS (7.423s)
[469.300385] Starting dynamic subtest: ccs0
[472.280264] Dynamic subtest ccs0: SUCCESS (3.008s)
[472.292892] Starting dynamic subtest: vcs0
[480.298237] Dynamic subtest vcs0: SUCCESS (8.036s)
[480.318222] Starting dynamic subtest: bcs0
[481.436108] Dynamic subtest bcs0: SUCCESS (1.135s)
[481.448534] Starting dynamic subtest: rcs0
[482.550666] Dynamic subtest rcs0: SUCCESS (1.115s)
[482.562249] Starting dynamic subtest: vcs1
[490.281962] Dynamic subtest vcs1: SUCCESS (7.731s)
[490.284531] Subtest precise: SUCCESS (28.462s)
[490.377391] [119/132] (534s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[490.480877] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[490.507014] Starting dynamic subtest: pipe-A-plane-0
[490.873733] Dynamic subtest pipe-A-plane-0: SUCCESS (0.366s)
[490.886277] Starting dynamic subtest: pipe-A-plane-3
[491.210553] Dynamic subtest pipe-A-plane-3: SUCCESS (0.333s)
[492.357784] Starting dynamic subtest: pipe-B-plane-0
[492.748291] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[492.760508] Starting dynamic subtest: pipe-B-plane-3
[493.081722] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[493.391213] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.909s)
[494.242332] [120/132] (530s left) kms_plane_alpha_blend (alpha-basic)
[494.335751] Starting subtest: alpha-basic
[494.633307] Starting dynamic subtest: pipe-A-eDP-1
[496.586990] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s)
[496.619514] Starting dynamic subtest: pipe-D-eDP-1
[499.316178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.706s)
[499.318543] Subtest alpha-basic: SUCCESS (4.980s)
[500.187127] [121/132] (524s left) kms_atomic (plane-overlay-legacy)
[500.275852] Starting subtest: plane-overlay-legacy
[500.278100] Starting dynamic subtest: pipe-A-eDP-1
[500.664236] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[500.666602] Subtest plane-overlay-legacy: SUCCESS (0.390s)
[501.552330] [122/132] (523s left) syncobj_timeline (invalid-query-one-illegal-handle)
[501.610320] Starting subtest: invalid-query-one-illegal-handle
[501.612711] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[501.708509] [123/132] (522s left) gem_unfence_active_buffers
[501.860328] [124/132] (522s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[501.976162] Starting subtest: 2x-flip-vs-cursor-legacy
[501.980793] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[502.126568] [125/132] (522s left) kms_vblank (crtc-id)
[502.230726] Starting subtest: crtc-id
[502.232638] Starting dynamic subtest: pipe-A-eDP-1
[502.673389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s)
[502.691191] Starting dynamic subtest: pipe-D-eDP-1
[503.855338] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.177s)
[503.857582] Subtest crtc-id: SUCCESS (1.625s)
[504.680344] [126/132] (520s left) prime_vgem (fence-write-hang)
[504.768958] Subtest fence-write-hang: SKIP (0.000s)
[504.881628] [127/132] (519s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[504.987578] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[504.989868] Starting dynamic subtest: pipe-A-eDP-1
[510.854387] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.869s)
[510.865974] Starting dynamic subtest: pipe-B-eDP-1
[517.482026] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.628s)
[517.484385] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.501s)
[518.347593] [128/132] (506s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[518.455433] Starting subtest: x-tiled-16bpp-rotate-180
[519.844951] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.390s)
[519.995978] [129/132] (504s left) perf_pmu (init-wait)
[520.038756] Starting subtest: init-wait
[520.040612] Starting dynamic subtest: rcs0
[520.042471] Dynamic subtest rcs0: SUCCESS (0.002s)
[520.054633] Starting dynamic subtest: bcs0
[520.056401] Dynamic subtest bcs0: SUCCESS (0.001s)
[520.066512] Starting dynamic subtest: vcs0
[520.068280] Dynamic subtest vcs0: SUCCESS (0.001s)
[520.078292] Starting dynamic subtest: vcs1
[520.080144] Dynamic subtest vcs1: SUCCESS (0.001s)
[520.090503] Starting dynamic subtest: vecs0
[520.092296] Dynamic subtest vecs0: SUCCESS (0.001s)
[520.104913] Starting dynamic subtest: ccs0
[520.106684] Dynamic subtest ccs0: SUCCESS (0.000s)
[520.108500] Subtest init-wait: SUCCESS (0.009s)
[520.160536] [130/132] (504s left) kms_big_fb (linear-8bpp-rotate-0)
[520.255093] Starting subtest: linear-8bpp-rotate-0
[521.536287] Subtest linear-8bpp-rotate-0: SUCCESS (1.281s)
[521.659602] [131/132] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[521.760731] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[521.763970] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[521.881681] [132/132] (503s left) i915_selftest (live)
[523.757527] Starting subtest: live
[523.759721] Starting dynamic subtest: sanitycheck
[526.568111] Dynamic subtest sanitycheck: SUCCESS (2.811s)
[526.580400] Starting dynamic subtest: uncore
[530.921816] Dynamic subtest uncore: SUCCESS (4.352s)
[530.933260] Starting dynamic subtest: workarounds
[548.231308] Dynamic subtest workarounds: FAIL (16.827s)
[548.239479] Starting dynamic subtest: gt_engines
[552.344791] Dynamic subtest gt_engines: SUCCESS (4.599s)
[552.353690] Starting dynamic subtest: gt_timelines
[568.372985] Dynamic subtest gt_timelines: SUCCESS (16.020s)
[568.389202] Starting dynamic subtest: gt_contexts
[572.768888] Dynamic subtest gt_contexts: SUCCESS (4.394s)
[572.779687] Starting dynamic subtest: gt_lrc
[578.950906] Dynamic subtest gt_lrc: SUCCESS (6.180s)
[578.961836] Starting dynamic subtest: gt_mocs
[581.962024] Dynamic subtest gt_mocs: SUCCESS (3.009s)
[581.976607] Starting dynamic subtest: gt_pm
[588.790274] Dynamic subtest gt_pm: SUCCESS (6.826s)
[588.799141] Starting dynamic subtest: gt_heartbeat
[591.548939] Dynamic subtest gt_heartbeat: SUCCESS (2.756s)
[591.559190] Starting dynamic subtest: gt_tlb
[600.833366] Dynamic subtest gt_tlb: SUCCESS (9.283s)
[600.844947] Starting dynamic subtest: requests
[614.375738] Dynamic subtest requests: SUCCESS (13.543s)
[614.387506] Starting dynamic subtest: migrate
[622.132997] Dynamic subtest migrate: SUCCESS (7.755s)
[622.144012] Starting dynamic subtest: active
[626.475415] Dynamic subtest active: SUCCESS (4.341s)
[626.485512] Starting dynamic subtest: objects
[629.782880] Dynamic subtest objects: SUCCESS (3.306s)
[629.793766] Starting dynamic subtest: mman
[634.886673] Dynamic subtest mman: SUCCESS (5.104s)
[634.897547] Starting dynamic subtest: dmabuf
[639.268597] Dynamic subtest dmabuf: SUCCESS (4.380s)
[639.279484] Starting dynamic subtest: vma
[643.673609] Dynamic subtest vma: SUCCESS (4.404s)
[643.690149] Starting dynamic subtest: coherency
[649.097313] Dynamic subtest coherency: SUCCESS (5.423s)
[649.105929] Starting dynamic subtest: gtt
[661.098693] Dynamic subtest gtt: SUCCESS (12.003s)
[661.110194] Starting dynamic subtest: gem
[668.995510] Dynamic subtest gem: SUCCESS (7.897s)
[669.005701] Starting dynamic subtest: evict
[674.594869] Dynamic subtest evict: SUCCESS (5.597s)
[674.605763] Starting dynamic subtest: hugepages
[685.464946] Dynamic subtest hugepages: SUCCESS (10.867s)
[685.475793] Starting dynamic subtest: gem_contexts
[712.215484] Dynamic subtest gem_contexts: SUCCESS (26.743s)
[712.230108] Starting dynamic subtest: client
[716.618251] Dynamic subtest client: SUCCESS (4.400s)
[716.636310] Starting dynamic subtest: gem_migrate
[721.060521] Dynamic subtest gem_migrate: SUCCESS (4.440s)
[721.071235] Starting dynamic subtest: reset
[723.877795] Dynamic subtest reset: SUCCESS (2.814s)
[723.889002] Starting dynamic subtest: memory_region
[728.267554] Dynamic subtest memory_region: SUCCESS (4.388s)
[728.278154] Starting dynamic subtest: hangcheck
[741.836811] Dynamic subtest hangcheck: SUCCESS (13.567s)
[741.850690] Starting dynamic subtest: execlists
[746.236366] Dynamic subtest execlists: SUCCESS (4.398s)
[746.247713] Starting dynamic subtest: ring_submission
[750.664491] Dynamic subtest ring_submission: SUCCESS (4.425s)
[750.675092] Starting dynamic subtest: perf
[755.055457] Dynamic subtest perf: SUCCESS (4.389s)
[755.066877] Starting dynamic subtest: slpc
[769.247170] Dynamic subtest slpc: SUCCESS (14.191s)
[769.258036] Starting dynamic subtest: guc
[773.255513] Dynamic subtest guc: SUCCESS (4.006s)
[773.267115] Starting dynamic subtest: guc_multi_lrc
[777.645719] Dynamic subtest guc_multi_lrc: SUCCESS (4.389s)
[777.657827] Starting dynamic subtest: guc_hang
[781.173995] Dynamic subtest guc_hang: SUCCESS (3.527s)
[781.183862] Starting dynamic subtest: late_gt_pm
[785.513817] Dynamic subtest late_gt_pm: SUCCESS (4.338s)
[785.516694] Subtest live: FAIL (261.758s)
[785.547746] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[785.548455] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[785.548792] Closing watchdogs
results: parsing output: 0/ for test: vgem_basic
results: parsing output: 1/ for test: kms_content_protection
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_psr
results: parsing output: 10/ for test: gem_exec_balancer
results: parsing output: 11/ for test: gen9_exec_parse
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_color
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: perf
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sw_sync
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_render_copy_redux
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_exec_params
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_reg_read
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: kms_debugfs
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_exec_fence
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: gem_spin_batch
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_chamelium_edid
results: parsing output: 48/ for test: kms_vblank
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_getfb
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: prime_self_import
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_params
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_joiner
results: parsing output: 62/ for test: gem_exec_suspend
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: kms_cursor_edge_walk
results: parsing output: 70/ for test: gem_busy
results: parsing output: 71/ for test: i915_module_load
results: parsing output: 72/ for test: gem_create
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_chamelium_hpd
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: gem_exec_whisper
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: device_reset
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: gem_partial_pwrite_pread
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: kms_flip_scaled_crc
results: parsing output: 87/ for test: i915_pm_rpm
results: parsing output: 88/ for test: gem_exec_capture
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: prime_vgem
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_plane_multiple
results: parsing output: 104/ for test: gem_lmem_swapping
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_fbcon_fbt
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_chamelium_color
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_exec_suspend
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_eio
results: parsing output: 114/ for test: kms_psr2_sf
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: sysfs_heartbeat_interval
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_plane_alpha_blend
results: parsing output: 120/ for test: kms_atomic
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gem_unfence_active_buffers
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: prime_vgem
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: i915_selftest
Done.