[57.758282] Initializing watchdogs
[57.758328]   /dev/watchdog0
[57.772321] [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]
[57.776749] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.778874] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.780815] [001/133] (960s left) gem_userptr_blits (process-exit)
[57.854602] Starting subtest: process-exit
[57.862189] Subtest process-exit: SUCCESS (0.008s)
[58.023574] [002/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[58.119168] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[58.121058] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[59.298207] [003/133] (959s left) i915_pm_rps (waitboost)
[59.349179] Starting subtest: waitboost
[65.442267] Subtest waitboost: SUCCESS (6.106s)
[65.567842] [004/133] (952s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[65.692653] Starting subtest: flip-vs-cursor-crc-atomic
[66.381573] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.689s)
[67.220884] [005/133] (951s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[67.518290] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[67.520524] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[67.854965] [006/133] (950s left) i915_pm_freq_api (freq-basic-api)
[67.919831] Starting subtest: freq-basic-api
[67.921117] Starting dynamic subtest: gt0
[67.923459] Dynamic subtest gt0: SUCCESS (0.003s)
[67.930406] Starting dynamic subtest: gt1
[67.931470] Dynamic subtest gt1: SUCCESS (0.004s)
[67.932460] Subtest freq-basic-api: SUCCESS (0.007s)
[68.267928] [007/133] (950s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[68.321245] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[68.428782] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[68.507061] [008/133] (950s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[68.609112] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[68.610023] Starting dynamic subtest: pipe-A-eDP-1
[68.618973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[68.627758] Starting dynamic subtest: pipe-B-eDP-1
[68.635415] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[68.644049] Starting dynamic subtest: pipe-C-eDP-1
[68.651602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[68.657236] Starting dynamic subtest: pipe-D-eDP-1
[68.665557] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[68.666517] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.004s)
[70.854909] [009/133] (947s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[70.943754] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[70.945686] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[71.023158] [010/133] (947s left) kms_pm_rpm (modeset-non-lpsp-stress)
[73.039165] Starting subtest: modeset-non-lpsp-stress
[74.187174] Subtest modeset-non-lpsp-stress: SKIP (1.147s)
[74.568803] [011/133] (944s left) kms_cursor_crc (cursor-dpms)
[74.697356] Starting subtest: cursor-dpms
[74.698385] Starting dynamic subtest: pipe-A-eDP-1
[77.720453] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.023s)
[77.726352] Starting dynamic subtest: pipe-D-eDP-1
[81.274888] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.554s)
[81.275968] Subtest cursor-dpms: SUCCESS (6.578s)
[82.131023] [012/133] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[82.231727] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[82.233457] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[82.342695] [013/133] (936s left) kms_content_protection (uevent-hdcp14)
[82.469362] Starting subtest: uevent-hdcp14
[82.471180] Subtest uevent-hdcp14: SKIP (0.000s)
[82.601063] [014/133] (936s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[82.656118] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[82.707807] [015/133] (936s left) perf_pmu (init-wait)
[82.743648] Starting subtest: init-wait
[82.744424] Starting dynamic subtest: rcs0
[82.745215] Dynamic subtest rcs0: SUCCESS (0.002s)
[82.752488] Starting dynamic subtest: bcs0
[82.753405] Dynamic subtest bcs0: SUCCESS (0.000s)
[82.759879] Starting dynamic subtest: vcs0
[82.761062] Dynamic subtest vcs0: SUCCESS (0.001s)
[82.766498] Starting dynamic subtest: vcs1
[82.767398] Dynamic subtest vcs1: SUCCESS (0.001s)
[82.772791] Starting dynamic subtest: vecs0
[82.773607] Dynamic subtest vecs0: SUCCESS (0.000s)
[82.778709] Starting dynamic subtest: ccs0
[82.779579] Dynamic subtest ccs0: SUCCESS (0.000s)
[82.780428] Subtest init-wait: SUCCESS (0.006s)
[82.870312] [016/133] (935s left) kms_addfb_basic (master-rmfb)
[82.925442] Starting subtest: master-rmfb
[82.926443] Subtest master-rmfb: SUCCESS (0.001s)
[83.060348] [017/133] (935s left) gem_userptr_blits (unsync-unmap-cycles)
[83.112153] Subtest unsync-unmap-cycles: SKIP (0.000s)
[83.278768] [018/133] (935s left) gem_mmap_gtt (zero-extend)
[83.340054] Subtest zero-extend: SKIP (0.000s)
[83.397816] [019/133] (935s left) perf (blocking-parameterized)
[83.521309] Starting subtest: blocking-parameterized
[103.545458] Subtest blocking-parameterized: SUCCESS (20.022s)
[103.584249] [020/133] (915s left) gem_exec_reloc (basic-wc-gtt-active)
[103.654593] Subtest basic-wc-gtt-active: SKIP (0.000s)
[103.723258] [021/133] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[103.823694] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[103.825441] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[103.945334] [022/133] (915s left) kms_vblank (ts-continuation-idle-hang)
[104.032541] Starting subtest: ts-continuation-idle-hang
[104.033552] Starting dynamic subtest: pipe-A-eDP-1
[130.718906] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.686s)
[130.726943] Starting dynamic subtest: pipe-D-eDP-1
[145.687349] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.966s)
[145.688313] Subtest ts-continuation-idle-hang: SUCCESS (41.655s)
[146.529921] [023/133] (872s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[146.596176] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[146.597212] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[146.707225] [024/133] (872s left) kms_psr (psr-cursor-render)
[146.807473] Starting subtest: psr-cursor-render
[146.808418] Starting dynamic subtest: eDP-1
[148.495987] Dynamic subtest eDP-1: SUCCESS (1.688s)
[148.496969] Subtest psr-cursor-render: SUCCESS (1.689s)
[149.370850] [025/133] (869s left) gem_tiled_blits (interruptible)
[149.436750] Subtest interruptible: SKIP (0.000s)
[149.515337] [026/133] (869s left) kms_tiled_display (basic-test-pattern)
[149.626888] Subtest basic-test-pattern: SKIP (0.000s)
[149.661409] [027/133] (869s left) gem_exec_params (dr1-dirt)
[149.721283] Starting subtest: DR1-dirt
[149.722336] Subtest DR1-dirt: SUCCESS (0.000s)
[149.821585] [028/133] (869s left) gem_eio (banned)
[150.021163] Starting subtest: banned
[150.588105] Subtest banned: SUCCESS (0.567s)
[150.766681] [029/133] (868s left) syncobj_timeline (wait-all-interrupted)
[150.816256] Starting subtest: wait-all-interrupted
[150.919973] Subtest wait-all-interrupted: SUCCESS (0.101s)
[150.994365] [030/133] (868s left) gem_lmem_swapping (heavy-random)
[151.029640] Subtest heavy-random: SKIP (0.000s)
[151.066586] [031/133] (868s left) kms_atomic (crtc-invalid-params-fence)
[151.149628] Starting subtest: crtc-invalid-params-fence
[151.150583] Starting dynamic subtest: pipe-A-eDP-1
[151.549066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[151.550059] Subtest crtc-invalid-params-fence: SUCCESS (0.400s)
[152.416687] [032/133] (866s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[152.512211] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[152.540315] Starting dynamic subtest: pipe-A-plane-0
[152.542269] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[152.549159] Starting dynamic subtest: pipe-A-plane-3
[152.550776] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[152.557070] Starting dynamic subtest: pipe-A-plane-5
[152.558649] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[153.611288] Starting dynamic subtest: pipe-B-plane-0
[153.612925] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[153.619164] Starting dynamic subtest: pipe-B-plane-3
[153.621180] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[153.628853] Starting dynamic subtest: pipe-B-plane-5
[153.630682] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[153.926507] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (1.413s)
[154.792537] [033/133] (864s left) gem_exec_fence (nb-await)
[154.968957] Starting subtest: nb-await
[154.970432] Starting dynamic subtest: rcs0
[155.039784] Dynamic subtest rcs0: SUCCESS (0.070s)
[155.048541] Starting dynamic subtest: bcs0
[155.098409] Dynamic subtest bcs0: SUCCESS (0.058s)
[155.106988] Starting dynamic subtest: vcs0
[155.157313] Dynamic subtest vcs0: SUCCESS (0.058s)
[155.165810] Starting dynamic subtest: vcs1
[155.218309] Dynamic subtest vcs1: SUCCESS (0.060s)
[155.228371] Starting dynamic subtest: vecs0
[155.279599] Dynamic subtest vecs0: SUCCESS (0.061s)
[155.288495] Starting dynamic subtest: ccs0
[155.337783] Dynamic subtest ccs0: SUCCESS (0.057s)
[155.339016] Subtest nb-await: SUCCESS (0.369s)
[156.950826] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[156.952516] [034/133] (862s left) syncobj_timeline (reset-signaled)
[157.012022] Starting subtest: reset-signaled
[157.013018] Subtest reset-signaled: SUCCESS (0.000s)
[157.122248] [035/133] (862s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[157.179515] Subtest writes-after-reads: SKIP (0.000s)
[157.263327] [036/133] (862s left) kms_invalid_mode (bad-vsync-start)
[157.356682] Starting subtest: bad-vsync-start
[157.357510] Starting dynamic subtest: pipe-A-eDP-1
[157.673668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.316s)
[157.681115] Starting dynamic subtest: pipe-B-eDP-1
[157.681978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[157.688494] Starting dynamic subtest: pipe-C-eDP-1
[157.689369] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[157.694876] Starting dynamic subtest: pipe-D-eDP-1
[157.695699] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[157.696571] Subtest bad-vsync-start: SUCCESS (0.328s)
[158.551240] [037/133] (860s left) gem_mmap_gtt (basic-small-bo-tiledy)
[158.598129] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[158.662327] [038/133] (860s left) kms_flip (flip-vs-fences-interruptible)
[158.757204] Starting subtest: flip-vs-fences-interruptible
[158.758848] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[158.883196] [039/133] (860s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[158.966791] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[158.968584] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[159.084145] [040/133] (860s left) kms_flip (dpms-off-confusion)
[159.169796] Starting subtest: dpms-off-confusion
[159.172062] Starting dynamic subtest: A-eDP1
[167.830874] Dynamic subtest A-eDP1: SUCCESS (8.659s)
[167.842947] Starting dynamic subtest: B-eDP1
[176.475943] Dynamic subtest B-eDP1: SUCCESS (8.643s)
[176.484898] Starting dynamic subtest: C-eDP1
[185.105796] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[185.114281] Starting dynamic subtest: D-eDP1
[193.744152] Dynamic subtest D-eDP1: SUCCESS (8.637s)
[193.746393] Subtest dpms-off-confusion: SUCCESS (34.575s)
[194.935108] [041/133] (824s left) kms_plane_alpha_blend (coverage-7efc)
[195.038202] Starting subtest: coverage-7efc
[195.324559] Starting dynamic subtest: pipe-A-eDP-1
[195.864544] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[195.888671] Starting dynamic subtest: pipe-D-eDP-1
[197.138922] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[197.139841] Subtest coverage-7efc: SUCCESS (2.102s)
[198.000511] [042/133] (821s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[198.115098] Starting subtest: 4-tiled-64bpp-rotate-0
[199.571241] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.456s)
[199.800219] [043/133] (819s left) kms_cursor_crc (cursor-tearing-framebuffer-change)
[199.907458] Starting subtest: cursor-tearing-framebuffer-change
[199.908435] Starting dynamic subtest: pipe-A-eDP-1
[200.481848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.573s)
[200.488606] Starting dynamic subtest: pipe-D-eDP-1
[201.731116] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[201.732059] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.823s)
[202.570996] [044/133] (817s left) kms_plane (pixel-format-yf-tiled-modifier)
[202.664133] Starting subtest: pixel-format-yf-tiled-modifier
[202.691714] Starting dynamic subtest: pipe-A-plane-0
[202.693612] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[202.700540] Starting dynamic subtest: pipe-A-plane-3
[202.702173] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[202.708067] Starting dynamic subtest: pipe-A-plane-5
[202.709715] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[203.753947] Starting dynamic subtest: pipe-B-plane-0
[203.755580] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[203.761578] Starting dynamic subtest: pipe-B-plane-3
[203.763199] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[203.769024] Starting dynamic subtest: pipe-B-plane-5
[203.770611] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[204.064443] Subtest pixel-format-yf-tiled-modifier: SKIP (1.398s)
[204.937211] [045/133] (814s left) gem_exec_balancer (bonded-true-hang)
[205.213928] Starting subtest: bonded-true-hang
[205.216494] Subtest bonded-true-hang: SKIP (0.000s)
[205.328513] [046/133] (814s left) gem_mmap_gtt (basic-write-read-distinct)
[205.377212] Subtest basic-write-read-distinct: SKIP (0.000s)
[205.430466] [047/133] (814s left) kms_pm_lpsp (screens-disabled)
[206.520043] Starting subtest: screens-disabled
[206.521971] Subtest screens-disabled: SKIP (0.000s)
[206.593833] [048/133] (813s left) gem_ctx_persistence (engines-queued)
[206.662780] Starting subtest: engines-queued
[206.663805] Starting dynamic subtest: rcs0
[206.772749] Dynamic subtest rcs0: SUCCESS (0.111s)
[206.782343] Starting dynamic subtest: bcs0
[206.844852] Dynamic subtest bcs0: SUCCESS (0.070s)
[206.854144] Starting dynamic subtest: vcs0
[208.889321] Dynamic subtest vcs0: SUCCESS (2.041s)
[208.898560] Starting dynamic subtest: vcs1
[210.871427] Dynamic subtest vcs1: SUCCESS (1.980s)
[210.881338] Starting dynamic subtest: vecs0
[212.855056] Dynamic subtest vecs0: SUCCESS (1.981s)
[212.864435] Starting dynamic subtest: ccs0
[213.037241] Dynamic subtest ccs0: SUCCESS (0.183s)
[213.038301] Subtest engines-queued: SUCCESS (6.376s)
[213.195160] [049/133] (806s left) kms_psr (psr-no-drrs)
[213.283075] Starting subtest: psr-no-drrs
[213.283966] Starting dynamic subtest: eDP-1
[214.925884] Dynamic subtest eDP-1: SUCCESS (1.642s)
[214.926722] Subtest psr-no-drrs: SUCCESS (1.643s)
[215.802288] [050/133] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[215.905143] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[215.906861] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[216.005967] [051/133] (803s left) gem_exec_async (concurrent-writes)
[216.069397] Starting subtest: concurrent-writes
[216.070303] Starting dynamic subtest: rcs0
[216.083219] Dynamic subtest rcs0: SUCCESS (0.015s)
[216.092294] Starting dynamic subtest: bcs0
[216.093123] Dynamic subtest bcs0: SUCCESS (0.006s)
[216.099487] Starting dynamic subtest: vcs0
[216.100314] Dynamic subtest vcs0: SUCCESS (0.005s)
[216.106248] Starting dynamic subtest: vcs1
[216.107028] Dynamic subtest vcs1: SUCCESS (0.007s)
[216.113033] Starting dynamic subtest: vecs0
[216.113911] Dynamic subtest vecs0: SUCCESS (0.006s)
[216.119926] Starting dynamic subtest: ccs0
[216.120761] Dynamic subtest ccs0: SUCCESS (0.005s)
[216.121588] Subtest concurrent-writes: SUCCESS (0.047s)
[216.371960] [052/133] (803s left) gem_flink_basic (basic)
[216.429680] Starting subtest: basic
[216.430682] Subtest basic: SUCCESS (0.000s)
[216.558450] [053/133] (803s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[216.649718] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[216.651932] Starting dynamic subtest: pipe-A-default-mode
[219.357062] Dynamic subtest pipe-A-default-mode: SUCCESS (2.706s)
[219.357962] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.707s)
[220.203330] [054/133] (799s left) kms_lease (possible-crtcs-filtering)
[220.313383] Starting subtest: possible-crtcs-filtering
[220.317857] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[220.436697] [055/133] (799s left) gem_exec_parallel (userptr)
[220.501184] Starting subtest: userptr
[220.502163] Starting dynamic subtest: rcs0
[221.949161] Dynamic subtest rcs0: SUCCESS (1.448s)
[221.955569] Starting dynamic subtest: bcs0
[223.421630] Dynamic subtest bcs0: SUCCESS (1.471s)
[223.431089] Starting dynamic subtest: vcs0
[224.899270] Dynamic subtest vcs0: SUCCESS (1.473s)
[224.907945] Starting dynamic subtest: vcs1
[226.903790] Dynamic subtest vcs1: SUCCESS (2.003s)
[226.912625] Starting dynamic subtest: vecs0
[228.888206] Dynamic subtest vecs0: SUCCESS (1.982s)
[228.897577] Starting dynamic subtest: ccs0
[230.406815] Dynamic subtest ccs0: SUCCESS (1.519s)
[230.408046] Subtest userptr: SUCCESS (9.906s)
[230.599198] [056/133] (789s left) gen7_exec_parse (cmd-crossing-page)
[230.655833] Subtest cmd-crossing-page: SKIP (0.000s)
[230.719809] [057/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[230.804572] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[237.578083] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.774s)
[237.733984] [058/133] (782s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[237.833265] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[237.834959] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[237.969562] [059/133] (782s left) kms_rotation_crc (sprite-rotation-90)
[238.069132] Starting subtest: sprite-rotation-90
[238.070941] Subtest sprite-rotation-90: SKIP (0.001s)
[238.180965] [060/133] (782s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[238.281211] Starting subtest: x-tiled-16bpp-rotate-90
[238.300315] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[238.442835] [061/133] (781s left) kms_chamelium_color (ctm-0-75)
[238.535821] Subtest ctm-0-75: SKIP (0.000s)
[238.575375] [062/133] (781s left) gem_pxp (reject-modify-context-protection-off-2)
[238.685813] Starting subtest: reject-modify-context-protection-off-2
[238.686817] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[238.812511] [063/133] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[238.911846] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[238.913550] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[239.033392] [064/133] (781s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[239.087374] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[239.196631] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[239.282840] [065/133] (781s left) gen9_exec_parse (valid-registers)
[239.348011] Subtest valid-registers: SKIP (0.000s)
[239.423435] [066/133] (780s left) gem_eio (in-flight-internal-immediate)
[239.659173] Starting subtest: in-flight-internal-immediate
[240.989107] Subtest in-flight-internal-immediate: SUCCESS (1.330s)
[241.146928] [067/133] (779s left) gem_tiled_pread_basic (basic)
[241.203371] Subtest basic: SKIP (0.000s)
[241.264398] [068/133] (779s left) kms_addfb_basic (unused-handle)
[241.314465] Starting subtest: unused-handle
[241.315414] Subtest unused-handle: SUCCESS (0.000s)
[241.461927] [069/133] (779s left) kms_psr (pr-primary-blt)
[241.562112] Starting subtest: pr-primary-blt
[241.563896] Subtest pr-primary-blt: SKIP (0.000s)
[241.640504] [070/133] (778s left) gem_exec_schedule (pi-ringfull)
[241.818925] Starting subtest: pi-ringfull
[241.820323] Starting dynamic subtest: rcs0
[241.856053] Dynamic subtest rcs0: SUCCESS (0.039s)
[241.869166] Starting dynamic subtest: bcs0
[241.891145] Dynamic subtest bcs0: SUCCESS (0.034s)
[241.901030] Starting dynamic subtest: vcs0
[241.926838] Dynamic subtest vcs0: SUCCESS (0.034s)
[241.935344] Starting dynamic subtest: vcs1
[241.961824] Dynamic subtest vcs1: SUCCESS (0.034s)
[241.969542] Starting dynamic subtest: vecs0
[241.992840] Dynamic subtest vecs0: SUCCESS (0.030s)
[241.999794] Starting dynamic subtest: ccs0
[242.021338] Dynamic subtest ccs0: SUCCESS (0.028s)
[242.022193] Subtest pi-ringfull: SUCCESS (0.205s)
[242.264723] [071/133] (778s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[242.336859] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[242.338753] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[242.527182] [072/133] (778s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[242.581857] Starting subtest: multi-wait-for-submit-submitted-signaled
[242.582928] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[242.675166] [073/133] (777s left) gem_close_race (multigpu-basic-process)
[242.736824] Starting subtest: multigpu-basic-process
[242.738888] Subtest multigpu-basic-process: SKIP (0.000s)
[242.974281] [074/133] (777s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[243.066103] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[244.044386] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.979s)
[244.208888] [075/133] (776s left) gem_softpin (overlap)
[244.262808] Starting subtest: overlap
[245.194057] Subtest overlap: SUCCESS (0.928s)
[245.330377] [076/133] (775s left) perf_pmu (interrupts-sync)
[245.365520] Starting subtest: interrupts-sync
[246.465887] Subtest interrupts-sync: SUCCESS (1.097s)
[246.612355] [077/133] (774s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[246.704055] Starting subtest: fbc-psr2-cursor-mmap-cpu
[246.704921] Starting dynamic subtest: eDP-1
[246.706801] Dynamic subtest eDP-1: SKIP (0.000s)
[246.708455] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[246.783370] [078/133] (774s left) kms_feature_discovery (dp-mst)
[246.876717] Starting subtest: dp-mst
[246.878497] Subtest dp-mst: SKIP (0.000s)
[246.953432] [079/133] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[247.041696] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[247.043553] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[247.192166] [080/133] (773s left) syncobj_timeline (etime-single-wait-all-submitted)
[247.255764] Starting subtest: etime-single-wait-all-submitted
[247.365164] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[247.444802] [081/133] (773s left) gem_ctx_persistence (legacy-engines-mixed-process)
[247.515608] Starting subtest: legacy-engines-mixed-process
[247.516741] Starting dynamic subtest: render
[248.935373] Dynamic subtest render: SUCCESS (1.419s)
[248.945201] Starting dynamic subtest: bsd1
[250.922312] Dynamic subtest bsd1: SUCCESS (1.984s)
[250.931962] Starting dynamic subtest: bsd2
[252.908421] Dynamic subtest bsd2: SUCCESS (1.984s)
[252.918862] Starting dynamic subtest: blt
[254.886119] Dynamic subtest blt: SUCCESS (1.975s)
[254.895637] Starting dynamic subtest: vebox
[256.936197] Dynamic subtest vebox: SUCCESS (2.048s)
[256.939417] Subtest legacy-engines-mixed-process: SUCCESS (9.422s)
[257.036125] [082/133] (763s left) kms_frontbuffer_tracking (psr-suspend)
[257.141093] Starting subtest: psr-suspend
[295.994310] Subtest psr-suspend: SUCCESS (8.873s)
[303.109472] [083/133] (724s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[303.201584] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[303.203293] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[304.316423] [084/133] (723s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[304.700003] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[305.486746] [085/133] (722s left) gem_mmap_wc (bad-offset)
[305.539327] Subtest bad-offset: SKIP (0.000s)
[305.596735] [086/133] (722s left) gem_exec_schedule (timeslicing)
[305.653523] Starting subtest: timeslicing
[305.654471] Starting dynamic subtest: rcs0
[305.674588] Dynamic subtest rcs0: SUCCESS (0.022s)
[305.684363] Starting dynamic subtest: bcs0
[305.695718] Dynamic subtest bcs0: SUCCESS (0.021s)
[305.705481] Starting dynamic subtest: vcs0
[305.716633] Dynamic subtest vcs0: SUCCESS (0.020s)
[305.724195] Starting dynamic subtest: vcs1
[305.736972] Dynamic subtest vcs1: SUCCESS (0.020s)
[305.744720] Starting dynamic subtest: vecs0
[305.757296] Dynamic subtest vecs0: SUCCESS (0.020s)
[305.764717] Starting dynamic subtest: ccs0
[305.777855] Dynamic subtest ccs0: SUCCESS (0.020s)
[305.778857] Subtest timeslicing: SUCCESS (0.127s)
[306.915087] [087/133] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[307.001167] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[307.002964] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[307.121644] [088/133] (721s left) sysfs_heartbeat_interval (invalid)
[307.186703] Starting subtest: invalid
[307.187709] Starting dynamic subtest: vecs0
[307.188690] Dynamic subtest vecs0: SUCCESS (0.000s)
[307.197495] Starting dynamic subtest: ccs0
[307.198400] Dynamic subtest ccs0: SUCCESS (0.000s)
[307.205686] Starting dynamic subtest: vcs0
[307.206556] Dynamic subtest vcs0: SUCCESS (0.000s)
[307.213795] Starting dynamic subtest: bcs0
[307.214731] Dynamic subtest bcs0: SUCCESS (0.000s)
[307.222092] Starting dynamic subtest: rcs0
[307.223022] Dynamic subtest rcs0: SUCCESS (0.000s)
[307.230383] Starting dynamic subtest: vcs1
[307.231325] Dynamic subtest vcs1: SUCCESS (0.000s)
[307.232253] Subtest invalid: SUCCESS (0.005s)
[307.337689] [089/133] (720s left) kms_psr (fbc-pr-primary-blt)
[307.426894] Starting subtest: fbc-pr-primary-blt
[307.428853] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[307.505202] [090/133] (720s left) gem_exec_schedule (wide)
[307.674866] Starting subtest: wide
[307.676063] Starting dynamic subtest: rcs0
[317.886940] Dynamic subtest rcs0: SUCCESS (10.265s)
[317.897698] Starting dynamic subtest: vcs0
[328.899575] Dynamic subtest vcs0: SUCCESS (11.029s)
[328.910348] Starting dynamic subtest: vcs1
[339.836458] Dynamic subtest vcs1: SUCCESS (10.940s)
[339.847340] Starting dynamic subtest: vecs0
[354.519861] Dynamic subtest vecs0: SUCCESS (14.689s)
[354.530870] Starting dynamic subtest: ccs0
[372.152351] Dynamic subtest ccs0: SUCCESS (17.639s)
[372.154480] Subtest wide: SUCCESS (64.569s)
[374.102492] [091/133] (654s left) api_intel_bb (offset-control)
[374.152613] Starting subtest: offset-control
[374.164598] Subtest offset-control: SUCCESS (0.013s)
[374.313054] [092/133] (653s left) fbdev (info)
[374.340172] Starting subtest: info
[374.341151] Subtest info: SUCCESS (0.000s)
[374.415668] [093/133] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[374.528214] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[374.529921] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[374.633525] [094/133] (653s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[375.007687] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[375.792084] [095/133] (652s left) gem_exec_reloc (basic-gtt)
[375.859492] Subtest basic-gtt: SKIP (0.000s)
[375.929122] [096/133] (652s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[376.032947] Starting subtest: y-tiled-8bpp-rotate-0
[376.034813] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[376.147820] [097/133] (652s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[376.238084] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[376.239018] Starting dynamic subtest: pipe-A-eDP-1
[376.264658] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.027s)
[376.274694] Starting dynamic subtest: pipe-B-eDP-1
[376.288534] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.023s)
[376.297662] Starting dynamic subtest: pipe-C-eDP-1
[376.312127] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[376.321484] Starting dynamic subtest: pipe-D-eDP-1
[376.337401] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s)
[376.338321] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.101s)
[378.494354] [098/133] (649s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[378.585824] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[385.568228] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.987s)
[385.699751] [099/133] (642s left) kms_big_fb (linear-8bpp-rotate-270)
[385.790908] Starting subtest: linear-8bpp-rotate-270
[385.811753] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[385.931477] [100/133] (642s left) api_intel_bb (blit-reloc-keep-cache)
[385.990792] Starting subtest: blit-reloc-keep-cache
[385.992479] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[386.131225] [101/133] (642s left) gem_tiled_partial_pwrite_pread (reads)
[386.188351] Subtest reads: SKIP (0.000s)
[386.255598] [102/133] (642s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[386.375700] Starting subtest: cursorA-vs-flipA-atomic
[397.515698] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.138s)
[398.323191] [103/133] (630s left) kms_busy (extended-modeset-hang-newfb)
[398.431412] Starting subtest: extended-modeset-hang-newfb
[398.432409] Starting dynamic subtest: pipe-A
[432.754499] Dynamic subtest pipe-A: SUCCESS (34.313s)
[432.763337] Starting dynamic subtest: pipe-D
[455.791740] Dynamic subtest pipe-D: SUCCESS (23.036s)
[455.792735] Subtest extended-modeset-hang-newfb: SUCCESS (57.353s)
[456.591832] [104/133] (572s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[456.658409] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[456.762226] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[456.842243] [105/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[456.957123] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[464.288049] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.334s)
[464.463928] [106/133] (564s left) kms_color_pipeline (plane-ctm3x4)
[464.556998] Starting subtest: plane-ctm3x4
[464.571148] Starting dynamic subtest: pipe-A-eDP-1
[464.994021] Dynamic subtest pipe-A-eDP-1: FAIL (0.280s)
[465.898510] Starting dynamic subtest: pipe-B-eDP-1
[466.338803] Dynamic subtest pipe-B-eDP-1: FAIL (0.257s)
[467.225819] Starting dynamic subtest: pipe-C-eDP-1
[467.651002] Dynamic subtest pipe-C-eDP-1: FAIL (0.212s)
[468.559263] Starting dynamic subtest: pipe-D-eDP-1
[469.005515] Dynamic subtest pipe-D-eDP-1: FAIL (0.224s)
[469.063664] Subtest plane-ctm3x4: FAIL (4.508s)
[469.926389] [107/133] (558s left) kms_cursor_crc (cursor-random-512x170)
[470.233728] Starting subtest: cursor-random-512x170
[470.235353] Subtest cursor-random-512x170: SKIP (0.001s)
[470.414660] [108/133] (558s left) kms_plane_scaling (invalid-num-scalers)
[470.499916] Starting subtest: invalid-num-scalers
[470.500812] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[470.517071] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.017s)
[470.526628] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[470.548316] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[470.556382] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[470.577304] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[470.586359] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[470.607170] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.028s)
[470.607999] Subtest invalid-num-scalers: SUCCESS (0.109s)
[470.745427] [109/133] (558s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[470.864884] Starting subtest: short-flip-after-cursor-atomic-transitions
[471.853447] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.987s)
[472.672966] [110/133] (556s left) gem_exec_params (invalid-bsd-ring)
[472.726695] Starting subtest: invalid-bsd-ring
[472.727672] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[472.837061] [111/133] (556s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[472.931882] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[477.153908] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.224s)
[478.285684] [112/133] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[478.377030] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[478.379018] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[478.488826] [113/133] (550s left) dmabuf_sync_file (export-wait-after-attach)
[478.521982] Starting subtest: export-wait-after-attach
[478.523159] Subtest export-wait-after-attach: SUCCESS (0.001s)
[478.586048] [114/133] (550s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[478.675010] Starting subtest: fbc-psr-sprite-mmap-cpu
[478.675969] Starting dynamic subtest: eDP-1
[478.677783] Dynamic subtest eDP-1: SKIP (0.000s)
[478.679460] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[478.757694] [115/133] (550s left) gem_mmap_gtt (basic-copy)
[478.800491] Subtest basic-copy: SKIP (0.000s)
[478.853974] [116/133] (550s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[478.944404] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[478.945412] Starting dynamic subtest: pipe-A-eDP-1
[479.030485] Dynamic subtest pipe-A-eDP-1: SKIP (0.087s)
[479.039531] Starting dynamic subtest: pipe-B-eDP-1
[480.152746] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[480.154446] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.211s)
[481.354912] [117/133] (547s left) drm_read (invalid-buffer)
[481.501591] Starting subtest: invalid-buffer
[481.502581] Subtest invalid-buffer: SUCCESS (0.000s)
[481.666147] [118/133] (547s left) kms_display_modes (extended-mode-basic)
[481.764018] Starting subtest: extended-mode-basic
[481.765799] Subtest extended-mode-basic: SKIP (0.000s)
[481.804617] [119/133] (547s left) prime_busy (hang)
[481.861440] Starting subtest: hang
[481.862425] Starting dynamic subtest: rcs0
[508.443309] Dynamic subtest rcs0: SUCCESS (26.588s)
[508.451336] Starting dynamic subtest: bcs0
[515.535750] Dynamic subtest bcs0: SUCCESS (7.093s)
[515.543956] Starting dynamic subtest: vcs0
[522.569214] Dynamic subtest vcs0: SUCCESS (7.033s)
[522.577177] Starting dynamic subtest: vcs1
[529.550197] Dynamic subtest vcs1: SUCCESS (6.977s)
[529.558108] Starting dynamic subtest: vecs0
[536.585270] Dynamic subtest vecs0: SUCCESS (7.031s)
[536.593177] Starting dynamic subtest: ccs0
[550.423559] Dynamic subtest ccs0: SUCCESS (13.831s)
[550.425079] Subtest hang: SUCCESS (68.561s)
[550.588365] [120/133] (478s left) i915_pm_rpm (gem-execbuf)
[552.098247] Starting subtest: gem-execbuf
[552.099537] Starting dynamic subtest: smem0
[553.846917] Dynamic subtest smem0: SUCCESS (1.750s)
[553.848088] Subtest gem-execbuf: SUCCESS (1.752s)
[553.943895] [121/133] (475s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[554.050306] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[554.052080] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[554.171409] [122/133] (475s left) sw_sync (sync_busy_fork_unixsocket)
[554.211800] Starting subtest: sync_busy_fork_unixsocket
[554.217571] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[554.282970] [123/133] (475s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[554.364678] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[561.343469] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.975s)
[561.496332] [124/133] (467s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[561.587970] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[561.588894] Starting dynamic subtest: pipe-A
[561.650595] Dynamic subtest pipe-A: SUCCESS (0.063s)
[561.660133] Starting dynamic subtest: pipe-B
[562.783343] Dynamic subtest pipe-B: SUCCESS (1.130s)
[562.793737] Starting dynamic subtest: pipe-C
[563.896748] Dynamic subtest pipe-C: SUCCESS (1.113s)
[563.906623] Starting dynamic subtest: pipe-D
[565.030515] Dynamic subtest pipe-D: SUCCESS (1.132s)
[565.031647] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.444s)
[566.229417] [125/133] (463s left) gem_mmap_gtt (big-copy-xy)
[566.282033] Subtest big-copy-XY: SKIP (0.000s)
[566.345724] [126/133] (463s left) prime_self_import (export-vs-gem_close-race)
[566.370334] Starting subtest: export-vs-gem_close-race
[571.466817] Subtest export-vs-gem_close-race: SUCCESS (5.095s)
[571.550173] [127/133] (457s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[571.656597] Starting subtest: yf-tiled-64bpp-rotate-90
[571.658249] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[571.785146] [128/133] (457s left) gem_softpin (evict-prime)
[571.866093] Starting subtest: evict-prime
[571.867032] Starting dynamic subtest: rcs0
[573.070321] Dynamic subtest rcs0: SUCCESS (1.202s)
[573.085937] Starting dynamic subtest: bcs0
[574.225409] Dynamic subtest bcs0: SUCCESS (1.153s)
[574.237347] Starting dynamic subtest: vcs0
[575.842279] Dynamic subtest vcs0: SUCCESS (1.613s)
[575.852996] Starting dynamic subtest: vcs1
[577.932705] Dynamic subtest vcs1: SUCCESS (2.087s)
[577.943497] Starting dynamic subtest: vecs0
[579.923207] Dynamic subtest vecs0: SUCCESS (1.988s)
[579.934324] Starting dynamic subtest: ccs0
[581.083287] Dynamic subtest ccs0: SUCCESS (1.160s)
[581.095116] Starting dynamic subtest: all
[582.863191] Dynamic subtest all: SUCCESS (1.776s)
[582.864494] Subtest evict-prime: SUCCESS (10.995s)
[582.949191] [129/133] (446s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[583.046376] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[583.047247] Starting dynamic subtest: pipe-A-default-mode
[585.735672] Dynamic subtest pipe-A-default-mode: SUCCESS (2.687s)
[585.736517] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.689s)
[586.612496] [130/133] (442s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[586.712801] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[586.714550] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[586.838528] [131/133] (442s left) gem_exec_fence (basic-await)
[587.010376] Starting subtest: basic-await
[587.011972] Starting dynamic subtest: rcs0
[587.083050] Dynamic subtest rcs0: SUCCESS (0.074s)
[587.095854] Starting dynamic subtest: bcs0
[587.155423] Dynamic subtest bcs0: SUCCESS (0.071s)
[587.166425] Starting dynamic subtest: vcs0
[587.231398] Dynamic subtest vcs0: SUCCESS (0.075s)
[587.243125] Starting dynamic subtest: vcs1
[587.308216] Dynamic subtest vcs1: SUCCESS (0.076s)
[587.321315] Starting dynamic subtest: vecs0
[587.386979] Dynamic subtest vecs0: SUCCESS (0.077s)
[587.397693] Starting dynamic subtest: ccs0
[587.459999] Dynamic subtest ccs0: SUCCESS (0.071s)
[587.461510] Subtest basic-await: SUCCESS (0.453s)
[589.021286] [132/133] (440s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[589.135366] Starting subtest: flip-vs-cursor-legacy
[596.213574] Subtest flip-vs-cursor-legacy: SUCCESS (7.077s)
[597.043774] [133/133] (432s left) gem_lmem_swapping (verify-random-ccs)
[597.089315] Subtest verify-random-ccs: SKIP (0.000s)
[597.120615] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_pm_rps
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_freq_api
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_psr2_sf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_content_protection
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_mmap_gtt
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_exec_reloc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: gem_tiled_blits
results: parsing output: 25/ for test: kms_tiled_display
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: gem_eio
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_atomic
results: parsing output: 31/ for test: kms_plane
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_invalid_mode
results: parsing output: 36/ for test: gem_mmap_gtt
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_plane
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_pm_lpsp
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_async
results: parsing output: 51/ for test: gem_flink_basic
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: gen7_exec_parse
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_chamelium_color
results: parsing output: 61/ for test: gem_pxp
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: gen9_exec_parse
results: parsing output: 65/ for test: gem_eio
results: parsing output: 66/ for test: gem_tiled_pread_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_close_race
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_softpin
results: parsing output: 75/ for test: perf_pmu
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_feature_discovery
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: gem_ctx_persistence
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: sysfs_heartbeat_interval
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: api_intel_bb
results: parsing output: 91/ for test: fbdev
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: syncobj_wait
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_color_pipeline
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_plane_scaling
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: drm_read
results: parsing output: 117/ for test: kms_display_modes
results: parsing output: 118/ for test: prime_busy
results: parsing output: 119/ for test: i915_pm_rpm
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_mmap_gtt
results: parsing output: 125/ for test: prime_self_import
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: gem_lmem_swapping
Done.