[75.099943] Initializing watchdogs
[75.099992]   /dev/watchdog0
[75.114641] [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]
[75.119265] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[75.121522] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[75.124943] [001/156] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[75.268574] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[82.794398] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.536s)
[82.914695] [002/156] (952s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[83.015037] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[87.736276] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.728s)
[87.846162] [003/156] (947s left) i915_drm_fdinfo (virtual-busy-hang)
[87.893852] Starting subtest: virtual-busy-hang
[87.898166] Subtest virtual-busy-hang: SKIP (0.000s)
[87.958742] [004/156] (947s left) kms_lease (lease-uevent)
[88.055191] Starting subtest: lease-uevent
[89.070790] Subtest lease-uevent: SUCCESS (1.016s)
[89.139248] [005/156] (946s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[89.245305] Starting subtest: yf-tiled-32bpp-rotate-0
[89.249454] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[89.334028] [006/156] (946s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[89.447810] Starting subtest: basic-busy-flip-before-cursor-legacy
[89.452242] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[89.589558] [007/156] (946s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc)
[89.686776] Starting subtest: hdr-rgb101010-draw-mmap-wc
[89.691632] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[89.783492] [008/156] (946s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[89.894889] Starting subtest: y-tiled-64bpp-rotate-90
[89.899178] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[89.993762] [009/156] (945s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-render)
[90.092284] Starting subtest: fbchdr-rgb101010-draw-render
[90.095580] Subtest fbchdr-rgb101010-draw-render: SKIP (0.000s)
[90.190713] [010/156] (945s left) kms_flip_event_leak (basic)
[90.277924] Starting subtest: basic
[90.279517] Starting dynamic subtest: pipe-A-eDP-1
[90.702932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[90.710845] Starting dynamic subtest: pipe-B-eDP-1
[91.867686] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.164s)
[91.875245] Starting dynamic subtest: pipe-C-eDP-1
[92.971379] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[92.980590] Starting dynamic subtest: pipe-D-eDP-1
[94.104808] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s)
[94.107192] Subtest basic: SUCCESS (3.827s)
[94.966296] [011/156] (941s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[95.072748] Starting subtest: yf-tiled-8bpp-rotate-90
[95.076956] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[95.174116] [012/156] (940s left) gem_ctx_shared (q-promotion)
[95.244752] Starting subtest: Q-promotion
[95.247242] Starting dynamic subtest: rcs0
[95.369912] Dynamic subtest rcs0: SUCCESS (0.123s)
[95.388177] Starting dynamic subtest: vcs0
[95.456724] Dynamic subtest vcs0: SUCCESS (0.088s)
[95.473879] Starting dynamic subtest: vcs1
[95.540504] Dynamic subtest vcs1: SUCCESS (0.083s)
[95.555618] Starting dynamic subtest: vecs0
[95.616718] Dynamic subtest vecs0: SUCCESS (0.075s)
[95.632141] Starting dynamic subtest: ccs0
[95.705764] Dynamic subtest ccs0: SUCCESS (0.088s)
[95.709336] Subtest Q-promotion: SUCCESS (0.461s)
[97.388779] [FACT gem_ctx_shared (q-promotion)] new: kernel.kmod_is_loaded.vgem: true
[97.392071] [013/156] (938s left) gen9_exec_parse (secure-batches)
[97.455463] Subtest secure-batches: SKIP (0.000s)
[97.522548] [014/156] (938s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[97.629241] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[97.631497] Starting dynamic subtest: pipe-A-default-mode
[100.415866] Dynamic subtest pipe-A-default-mode: SUCCESS (2.786s)
[100.418172] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.787s)
[101.256385] [015/156] (934s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[101.346154] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[101.348482] Starting dynamic subtest: pipe-A-eDP-1
[101.407174] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[101.419979] Starting dynamic subtest: pipe-B-eDP-1
[101.474912] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[101.484163] Starting dynamic subtest: pipe-C-eDP-1
[101.540689] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[101.549694] Starting dynamic subtest: pipe-D-eDP-1
[101.606458] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[101.610799] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[103.624870] [016/156] (932s left) kms_plane (plane-panning-bottom-right-suspend)
[103.718119] Starting subtest: plane-panning-bottom-right-suspend
[103.720073] Starting dynamic subtest: pipe-A
[122.412550] Dynamic subtest pipe-A: SUCCESS (3.351s)
[122.422986] Starting dynamic subtest: pipe-B
[141.407117] Dynamic subtest pipe-B: SUCCESS (3.912s)
[141.409260] Subtest plane-panning-bottom-right-suspend: SUCCESS (7.266s)
[151.237904] [017/156] (894s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[151.340105] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[151.344436] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[151.439676] [018/156] (893s left) kms_chamelium_color (ctm-blue-to-red)
[151.535082] Subtest ctm-blue-to-red: SKIP (0.000s)
[151.581901] [019/156] (893s left) i915_module_load (reload-no-display)
[151.614729] Starting subtest: reload-no-display
[157.526313] Subtest reload-no-display: SUCCESS (5.991s)
[157.556832] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[157.557519] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[157.560311] [020/156] (887s left) kms_joiner (basic-force-ultra-joiner)
[159.135008] Starting subtest: basic-force-ultra-joiner
[159.139205] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[159.221054] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[159.224255] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true
[159.228231] [021/156] (886s left) kms_chamelium_hpd (dp-hpd-fast)
[159.615194] Subtest dp-hpd-fast: SKIP (0.000s)
[160.471070] [022/156] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[160.567322] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[167.920009] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.388s)
[168.070840] [023/156] (877s left) gem_exec_balancer (invalid-bonds)
[168.137336] Starting subtest: invalid-bonds
[168.142653] Subtest invalid-bonds: SKIP (0.000s)
[168.463418] [024/156] (877s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[168.562236] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[168.566323] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[168.667683] [025/156] (876s left) gem_fence_thrash (bo-write-verify-x)
[168.705271] Starting subtest: bo-write-verify-x
[168.727689] Subtest bo-write-verify-x: SKIP (0.021s)
[168.790301] [026/156] (876s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[168.878668] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[168.880884] Starting dynamic subtest: pipe-A-eDP-1
[203.258520] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.720s)
[203.269760] Starting dynamic subtest: pipe-B-eDP-1
[238.182214] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.490s)
[238.191835] Starting dynamic subtest: pipe-C-eDP-1
[273.179161] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.554s)
[273.190438] Starting dynamic subtest: pipe-D-eDP-1
[308.171874] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.455s)
[308.174275] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.224s)
[317.411006] [027/156] (736s left) dmabuf (all-tests)
[317.461027] Starting subtest: all-tests
[317.465550] Subtest all-tests: SKIP (0.000s)
[317.524040] [028/156] (736s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-render)
[317.630128] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-render
[317.634165] Subtest hdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[317.723519] [029/156] (736s left) kms_rotation_crc (sprite-rotation-180)
[317.816791] Starting subtest: sprite-rotation-180
[324.535789] Subtest sprite-rotation-180: SUCCESS (6.799s)
[325.786352] [030/156] (728s left) syncobj_basic (bad-flags-fd-to-handle)
[325.842402] Starting subtest: bad-flags-fd-to-handle
[325.844726] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[325.942567] [031/156] (727s left) gem_exec_params (rs-invalid)
[325.999005] Starting subtest: rs-invalid
[326.001476] Subtest rs-invalid: SUCCESS (0.003s)
[326.118349] [032/156] (727s left) kms_feature_discovery (display-2x)
[326.214576] Starting subtest: display-2x
[326.218865] Subtest display-2x: SKIP (0.000s)
[326.290506] [033/156] (727s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[326.387530] Starting subtest: plane-all-modeset-transition-fencing
[326.391834] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[326.461520] [034/156] (727s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render)
[326.557076] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render
[326.561605] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[326.657303] [035/156] (727s left) syncobj_timeline (invalid-wait-bad-flags)
[326.704921] Starting subtest: invalid-wait-bad-flags
[326.706881] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[326.821433] [036/156] (727s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-onoff)
[326.915690] Starting subtest: psrhdr-1p-primscrn-cur-indfb-onoff
[326.919190] Subtest psrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[327.028706] [037/156] (727s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[327.117279] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[327.120575] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[327.204702] [038/156] (726s left) gem_mmap_gtt (ptrace)
[327.255679] Subtest ptrace: SKIP (0.000s)
[327.311154] [039/156] (726s left) prime_vgem (basic-fence-read)
[327.378668] Starting subtest: basic-fence-read
[327.390619] Subtest basic-fence-read: SKIP (0.012s)
[327.493163] [040/156] (726s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-linear)
[327.585397] Starting subtest: fbcpsrhdr-tiling-linear
[327.588823] Subtest fbcpsrhdr-tiling-linear: SKIP (0.000s)
[327.701307] [041/156] (726s left) kms_psr (pr-cursor-blt)
[327.792002] Starting subtest: pr-cursor-blt
[327.795772] Subtest pr-cursor-blt: SKIP (0.000s)
[327.863356] [042/156] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[327.964650] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[327.968056] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[328.060246] [043/156] (726s left) gem_mmap_gtt (big-bo-tiledy)
[328.115221] Subtest big-bo-tiledY: SKIP (0.000s)
[328.173764] [044/156] (726s left) kms_flip (flip-vs-rmfb)
[328.270154] Starting subtest: flip-vs-rmfb
[328.271768] Starting dynamic subtest: A-eDP1
[336.960210] Dynamic subtest A-eDP1: SUCCESS (8.714s)
[336.971515] Starting dynamic subtest: B-eDP1
[345.665508] Dynamic subtest B-eDP1: SUCCESS (8.712s)
[345.675999] Starting dynamic subtest: C-eDP1
[354.321688] Dynamic subtest C-eDP1: SUCCESS (8.655s)
[354.333320] Starting dynamic subtest: D-eDP1
[363.054944] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[363.059284] Subtest flip-vs-rmfb: SUCCESS (34.824s)
[364.311410] [045/156] (690s left) syncobj_timeline (32bits-limit)
[364.364032] Starting subtest: 32bits-limit
[364.366611] Subtest 32bits-limit: SUCCESS (0.002s)
[364.461012] [046/156] (690s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[364.512690] Starting subtest: multi-wait-available-unsubmitted-submitted
[364.515011] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[364.638194] [047/156] (689s left) gem_close_race (multigpu-basic-process)
[364.692907] Starting subtest: multigpu-basic-process
[364.697553] Subtest multigpu-basic-process: SKIP (0.000s)
[364.930991] [048/156] (689s left) kms_cursor_crc (cursor-onscreen-128x128)
[365.141144] Starting subtest: cursor-onscreen-128x128
[365.146053] Starting dynamic subtest: pipe-A-eDP-1
[367.265677] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s)
[367.296773] Starting dynamic subtest: pipe-D-eDP-1
[370.082152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[370.084391] Subtest cursor-onscreen-128x128: SUCCESS (4.943s)
[370.958421] [049/156] (683s left) gem_spin_batch (resubmit)
[371.020067] Starting subtest: resubmit
[371.022505] Starting dynamic subtest: rcs0
[371.028769] Dynamic subtest rcs0: SUCCESS (0.008s)
[371.039747] Starting dynamic subtest: bcs0
[371.042123] Dynamic subtest bcs0: SUCCESS (0.003s)
[371.057775] Starting dynamic subtest: vcs0
[371.060163] Dynamic subtest vcs0: SUCCESS (0.002s)
[371.070381] Starting dynamic subtest: vcs1
[371.072619] Dynamic subtest vcs1: SUCCESS (0.003s)
[371.081775] Starting dynamic subtest: vecs0
[371.083970] Dynamic subtest vecs0: SUCCESS (0.002s)
[371.093036] Starting dynamic subtest: ccs0
[371.095258] Dynamic subtest ccs0: SUCCESS (0.003s)
[371.097487] Subtest resubmit: SUCCESS (0.026s)
[371.276296] [050/156] (683s left) i915_pm_rps (thresholds-park)
[371.338913] Starting subtest: thresholds-park
[371.343278] Subtest thresholds-park: SKIP (0.001s)
[371.448679] [051/156] (683s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[371.562439] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[372.385946] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[372.536438] [052/156] (682s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[372.631708] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[372.635650] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[372.728235] [053/156] (682s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[372.818304] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[372.822258] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[372.923158] [054/156] (681s left) i915_pm_rc6_residency (rc6-fence)
[372.976269] Starting subtest: rc6-fence
[373.016962] Starting dynamic subtest: gt0
[385.337593] Dynamic subtest gt0: SUCCESS (12.324s)
[385.350851] Starting dynamic subtest: gt1
[399.850523] Dynamic subtest gt1: SUCCESS (14.515s)
[399.853615] Subtest rc6-fence: SUCCESS (26.888s)
[399.932926] [055/156] (654s left) gem_exec_parallel (fds)
[400.004407] Starting subtest: fds
[400.006802] Starting dynamic subtest: rcs0
[403.537200] Dynamic subtest rcs0: SUCCESS (3.532s)
[403.548881] Starting dynamic subtest: bcs0
[406.989906] Dynamic subtest bcs0: SUCCESS (3.452s)
[407.003307] Starting dynamic subtest: vcs0
[411.075178] Dynamic subtest vcs0: SUCCESS (4.079s)
[411.086111] Starting dynamic subtest: vcs1
[415.102091] Dynamic subtest vcs1: SUCCESS (4.022s)
[415.114775] Starting dynamic subtest: vecs0
[419.105311] Dynamic subtest vecs0: SUCCESS (3.999s)
[419.116861] Starting dynamic subtest: ccs0
[422.785913] Dynamic subtest ccs0: SUCCESS (3.677s)
[422.788523] Subtest fds: SUCCESS (22.777s)
[422.998191] [056/156] (631s left) syncobj_wait (invalid-signal-illegal-handle)
[423.052407] Starting subtest: invalid-signal-illegal-handle
[423.054810] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[423.164631] [057/156] (631s left) kms_setmode (basic)
[423.219200] Starting subtest: basic
[423.546178] Starting dynamic subtest: pipe-A-eDP-1
[425.663799] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[426.007823] Starting dynamic subtest: pipe-B-eDP-1
[428.093773] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.091s)
[428.400577] Subtest basic: SUCCESS (5.181s)
[429.255892] [058/156] (625s left) prime_mmap_kms (buffer-sharing)
[429.345750] Starting subtest: buffer-sharing
[429.797419] Subtest buffer-sharing: SUCCESS (0.452s)
[430.692141] [059/156] (624s left) kms_chamelium_frames (dp-crc-multiple)
[431.070316] Subtest dp-crc-multiple: SKIP (0.000s)
[431.900516] [060/156] (623s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt)
[431.997513] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt
[432.002051] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[432.108656] [061/156] (623s left) kms_psr (psr-primary-blt)
[432.199635] Starting subtest: psr-primary-blt
[432.201892] Starting dynamic subtest: eDP-1
[433.924520] Dynamic subtest eDP-1: SUCCESS (1.724s)
[433.926846] Subtest psr-primary-blt: SUCCESS (1.726s)
[434.799997] [062/156] (620s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[434.896334] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[434.900383] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[434.991367] [063/156] (620s left) kms_psr (psr2-cursor-plane-move)
[435.089163] Starting subtest: psr2-cursor-plane-move
[435.091542] Starting dynamic subtest: eDP-1
[436.779318] Dynamic subtest eDP-1: SUCCESS (1.691s)
[436.781616] Subtest psr2-cursor-plane-move: SUCCESS (1.692s)
[437.666003] [064/156] (617s left) gem_mmap_gtt (basic-write-read-distinct)
[437.716296] Subtest basic-write-read-distinct: SKIP (0.000s)
[437.781450] [065/156] (617s left) kms_color (ctm-0-50)
[437.878632] Starting subtest: ctm-0-50
[437.880486] Starting dynamic subtest: pipe-A-eDP-1
[441.390283] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.512s)
[441.403144] Starting dynamic subtest: pipe-B-eDP-1
[445.702622] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.312s)
[445.714870] Starting dynamic subtest: pipe-C-eDP-1
[449.754349] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.050s)
[449.764731] Starting dynamic subtest: pipe-D-eDP-1
[453.771003] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.017s)
[453.773296] Subtest ctm-0-50: SUCCESS (15.895s)
[454.606889] [066/156] (600s left) kms_hdmi_inject (inject-4k)
[454.951661] Starting subtest: inject-4k
[455.302297] Subtest inject-4k: SUCCESS (0.352s)
[455.883063] [067/156] (599s left) perf (blocking)
[456.022405] Starting subtest: blocking
[456.024730] Starting dynamic subtest: 0-rcs0
[466.037996] Dynamic subtest 0-rcs0: SUCCESS (10.017s)
[466.052291] Starting dynamic subtest: 1-vcs1
[476.061151] Dynamic subtest 1-vcs1: SUCCESS (10.023s)
[476.064087] Subtest blocking: SUCCESS (20.043s)
[476.115064] [068/156] (579s left) gem_wait (write-wait)
[476.179647] Starting subtest: write-wait
[476.181939] Starting dynamic subtest: all-engines
[477.323358] Dynamic subtest all-engines: SUCCESS (1.143s)
[477.343167] Starting dynamic subtest: rcs0
[478.391645] Dynamic subtest rcs0: SUCCESS (1.065s)
[478.407696] Starting dynamic subtest: bcs0
[479.454279] Dynamic subtest bcs0: SUCCESS (1.060s)
[479.472678] Starting dynamic subtest: vcs0
[480.514704] Dynamic subtest vcs0: SUCCESS (1.059s)
[480.533543] Starting dynamic subtest: vcs1
[481.570807] Dynamic subtest vcs1: SUCCESS (1.054s)
[481.588591] Starting dynamic subtest: vecs0
[482.626220] Dynamic subtest vecs0: SUCCESS (1.053s)
[482.643522] Starting dynamic subtest: ccs0
[483.683930] Dynamic subtest ccs0: SUCCESS (1.056s)
[483.686386] Subtest write-wait: SUCCESS (7.507s)
[483.896200] [069/156] (571s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff)
[483.997090] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff
[484.001310] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[484.104290] [070/156] (571s left) gem_softpin (32b-excludes-last-page)
[484.160707] Starting subtest: 32b-excludes-last-page
[484.165363] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[484.290975] [071/156] (571s left) kms_psr (fbc-pr-no-drrs)
[484.387612] Starting subtest: fbc-pr-no-drrs
[484.392142] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[484.462330] [072/156] (571s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[484.555679] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[484.559855] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[484.650250] [073/156] (570s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-render)
[484.754463] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-render
[484.758558] Subtest hdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[484.854644] [074/156] (570s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[484.941058] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[484.943065] Starting dynamic subtest: pipe-A-eDP-1
[484.960675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[484.971695] Starting dynamic subtest: pipe-B-eDP-1
[484.987959] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[484.997877] Starting dynamic subtest: pipe-C-eDP-1
[485.014318] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[485.024111] Starting dynamic subtest: pipe-D-eDP-1
[485.040147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[485.041734] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[487.262125] [075/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[487.366531] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[487.370679] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[487.462553] [076/156] (568s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[487.554410] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[487.558850] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[487.654460] [077/156] (568s left) gem_mmap_offset (ptrace)
[487.711099] Starting subtest: ptrace
[487.713522] Starting dynamic subtest: smem0-wb
[487.729508] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[487.741458] Starting dynamic subtest: smem0-wc
[487.751722] Dynamic subtest smem0-wc: SUCCESS (0.022s)
[487.764390] Starting dynamic subtest: smem0-uc
[487.774862] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[487.777435] Subtest ptrace: SUCCESS (0.067s)
[487.886429] [078/156] (567s left) sysfs_heartbeat_interval (precise)
[487.936361] Starting subtest: precise
[487.938617] Starting dynamic subtest: vecs0
[495.850495] Dynamic subtest vecs0: SUCCESS (7.912s)
[495.865885] Starting dynamic subtest: ccs0
[496.961326] Dynamic subtest ccs0: SUCCESS (1.110s)
[496.974252] Starting dynamic subtest: vcs0
[504.864835] Dynamic subtest vcs0: SUCCESS (7.906s)
[504.877599] Starting dynamic subtest: bcs0
[505.944634] Dynamic subtest bcs0: SUCCESS (1.077s)
[505.958190] Starting dynamic subtest: rcs0
[507.033928] Dynamic subtest rcs0: SUCCESS (1.088s)
[507.044537] Starting dynamic subtest: vcs1
[514.882595] Dynamic subtest vcs1: SUCCESS (7.849s)
[514.885547] Subtest precise: SUCCESS (26.954s)
[514.962168] [079/156] (540s left) core_getclient (basic)
[515.021454] Starting subtest: basic
[515.023548] Subtest basic: SUCCESS (0.000s)
[515.129790] [080/156] (540s left) kms_setmode (invalid-clone-exclusive-crtc)
[515.175716] Starting subtest: invalid-clone-exclusive-crtc
[515.182470] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[515.315816] [081/156] (540s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[515.368582] Starting subtest: multi-wait-all-for-submit-unsubmitted
[515.478724] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[515.559589] [082/156] (540s left) kms_content_protection (atomic)
[515.707846] Starting subtest: atomic
[515.712154] Subtest atomic: SKIP (0.000s)
[516.026472] [083/156] (540s left) kms_getfb (getfb-addfb-different-handles)
[516.120594] Starting subtest: getfb-addfb-different-handles
[516.122730] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[516.220987] [084/156] (539s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[516.327010] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[516.331095] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[516.422917] [085/156] (539s left) gem_exec_params (rel-constants-invalid-ring)
[516.472246] Starting subtest: rel-constants-invalid-ring
[516.474611] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[516.586781] [086/156] (539s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[516.682785] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[520.756193] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.078s)
[521.928694] [087/156] (534s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[522.026810] Starting subtest: x-tiled-16bpp-rotate-180
[523.361125] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.336s)
[523.487337] [088/156] (532s left) syncobj_basic (bad-pad-handle-to-fd)
[523.542616] Starting subtest: bad-pad-handle-to-fd
[523.544683] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[523.635132] [089/156] (532s left) gem_exec_schedule (independent)
[523.697054] Starting subtest: independent
[523.698682] Starting dynamic subtest: rcs0
[524.842111] Dynamic subtest rcs0: SUCCESS (1.152s)
[524.856316] Starting dynamic subtest: vcs0
[526.825607] Dynamic subtest vcs0: SUCCESS (1.982s)
[526.839455] Starting dynamic subtest: vcs1
[528.887252] Dynamic subtest vcs1: SUCCESS (2.059s)
[528.901882] Starting dynamic subtest: vecs0
[530.877900] Dynamic subtest vecs0: SUCCESS (1.989s)
[530.891307] Starting dynamic subtest: ccs0
[532.842782] Dynamic subtest ccs0: SUCCESS (1.964s)
[532.845426] Subtest independent: SUCCESS (9.157s)
[533.153377] [090/156] (523s left) kms_pm_backlight (fade-with-dpms)
[533.244653] Starting subtest: fade-with-dpms
[535.354167] Starting dynamic subtest: eDP-1
[538.371699] Dynamic subtest eDP-1: SUCCESS (3.015s)
[538.373875] Subtest fade-with-dpms: SUCCESS (5.126s)
[539.218889] [091/156] (517s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[539.334941] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[539.339436] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[539.440824] [092/156] (517s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[539.540067] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[539.544261] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[539.625606] [093/156] (516s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[539.716657] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[539.720811] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[539.830168] [094/156] (516s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[539.929647] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[540.025859] [095/156] (516s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[540.125767] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[540.129097] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[540.221434] [096/156] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[540.324498] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[540.327886] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[540.417981] [097/156] (516s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[540.514685] Starting subtest: fbc-psr2-primary-mmap-gtt
[540.516658] Starting dynamic subtest: eDP-1
[540.520175] Dynamic subtest eDP-1: SKIP (0.000s)
[540.523695] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[540.602398] [098/156] (516s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[540.698928] Starting subtest: psr-rgb101010-draw-mmap-cpu
[547.803778] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.106s)
[547.928617] [099/156] (508s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[548.020448] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[548.022736] Starting dynamic subtest: pipe-A-eDP-1
[548.041996] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[548.053073] Starting dynamic subtest: pipe-B-eDP-1
[548.071870] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[548.082316] Starting dynamic subtest: pipe-C-eDP-1
[548.100901] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[548.113056] Starting dynamic subtest: pipe-D-eDP-1
[548.131728] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[548.133547] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s)
[550.313326] [100/156] (506s left) gem_exec_params (invalid-ring2)
[550.363104] Starting subtest: invalid-ring2
[550.365512] Subtest invalid-ring2: SUCCESS (0.000s)
[550.456361] [101/156] (506s left) kms_debugfs (display-off-read-all)
[550.546172] Starting subtest: display-off-read-all
[550.844153] Subtest display-off-read-all: SUCCESS (0.301s)
[551.714841] [102/156] (505s left) gem_ctx_persistence (saturated-hostile)
[551.778227] Starting subtest: saturated-hostile
[551.780556] Starting dynamic subtest: rcs0
[552.588867] Dynamic subtest rcs0: SUCCESS (0.813s)
[552.602386] Starting dynamic subtest: bcs0
[553.371357] Dynamic subtest bcs0: SUCCESS (0.780s)
[553.385272] Starting dynamic subtest: vcs0
[554.147894] Dynamic subtest vcs0: SUCCESS (0.774s)
[554.162145] Starting dynamic subtest: vcs1
[554.941530] Dynamic subtest vcs1: SUCCESS (0.792s)
[554.954966] Starting dynamic subtest: vecs0
[555.740749] Dynamic subtest vecs0: SUCCESS (0.797s)
[555.752128] Starting dynamic subtest: ccs0
[556.577621] Dynamic subtest ccs0: SUCCESS (0.834s)
[556.580516] Subtest saturated-hostile: SUCCESS (4.802s)
[556.693715] [103/156] (500s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[556.786303] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[556.790782] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[556.890104] [104/156] (500s left) prime_vgem (basic-blt)
[556.960449] Starting subtest: basic-blt
[556.993866] Subtest basic-blt: SUCCESS (0.033s)
[557.126414] [105/156] (499s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[557.226731] Starting subtest: pipe-fbc-rte
[557.233194] Starting dynamic subtest: pipe-B-eDP-1
[562.661001] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.438s)
[562.668632] Subtest pipe-fbc-rte: SUCCESS (5.441s)
[564.911458] [106/156] (492s left) gem_caching (writes)
[564.964444] Subtest writes: SKIP (0.000s)
[565.043472] [107/156] (492s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[565.135395] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[565.139615] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[565.234015] [108/156] (491s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[565.325133] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[565.329439] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[565.420352] [109/156] (491s left) kms_pm_rpm (modeset-non-lpsp-stress)
[567.043352] Starting subtest: modeset-non-lpsp-stress
[568.186148] Subtest modeset-non-lpsp-stress: SKIP (1.145s)
[568.596490] [110/156] (488s left) kms_universal_plane (disable-primary-vs-flip)
[568.693756] Starting subtest: disable-primary-vs-flip
[568.695630] Starting dynamic subtest: pipe-A-eDP-1
[570.277061] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.582s)
[570.288112] Starting dynamic subtest: pipe-B-eDP-1
[572.492618] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.214s)
[572.503597] Starting dynamic subtest: pipe-C-eDP-1
[574.667453] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.173s)
[574.678649] Starting dynamic subtest: pipe-D-eDP-1
[576.861840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.193s)
[576.864071] Subtest disable-primary-vs-flip: SUCCESS (8.166s)
[577.713744] [111/156] (479s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[577.813409] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[577.817886] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[577.910300] [112/156] (479s left) perf_pmu (busy-double-start)
[577.948672] Starting subtest: busy-double-start
[577.951155] Starting dynamic subtest: rcs0
[581.585858] Dynamic subtest rcs0: FAIL (3.578s)
[581.598501] Starting dynamic subtest: bcs0
[585.095276] Dynamic subtest bcs0: SUCCESS (3.567s)
[585.108480] Starting dynamic subtest: vcs0
[589.354805] Dynamic subtest vcs0: SUCCESS (4.257s)
[589.367443] Starting dynamic subtest: vcs1
[593.380691] Dynamic subtest vcs1: SUCCESS (4.023s)
[593.391508] Starting dynamic subtest: vecs0
[597.371190] Dynamic subtest vecs0: SUCCESS (3.989s)
[597.383794] Starting dynamic subtest: ccs0
[601.004531] Dynamic subtest ccs0: FAIL (3.566s)
[601.006738] Subtest busy-double-start: FAIL (22.989s)
[601.056949] [113/156] (456s left) gem_exec_store (cachelines)
[601.128584] Starting subtest: cachelines
[601.131031] Starting dynamic subtest: rcs0
[601.210894] Dynamic subtest rcs0: SUCCESS (0.082s)
[601.225596] Starting dynamic subtest: bcs0
[601.266154] Dynamic subtest bcs0: SUCCESS (0.054s)
[601.278331] Starting dynamic subtest: vcs0
[601.321438] Dynamic subtest vcs0: SUCCESS (0.053s)
[601.333944] Starting dynamic subtest: vcs1
[601.385389] Dynamic subtest vcs1: SUCCESS (0.062s)
[601.397839] Starting dynamic subtest: vecs0
[601.449328] Dynamic subtest vecs0: SUCCESS (0.062s)
[601.464615] Starting dynamic subtest: ccs0
[601.512069] Dynamic subtest ccs0: SUCCESS (0.060s)
[601.514656] Subtest cachelines: SUCCESS (0.386s)
[601.719599] [114/156] (455s left) prime_mmap_coherency (read)
[601.788307] Starting subtest: read
[607.167367] Subtest read: SUCCESS (5.377s)
[607.300631] [115/156] (450s left) gem_lmem_swapping (massive)
[607.347357] Subtest massive: SKIP (0.000s)
[607.386997] [116/156] (450s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[607.498356] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[614.915505] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.421s)
[615.038018] [117/156] (442s left) gem_mmap_gtt (basic-small-copy-odd)
[615.089724] Subtest basic-small-copy-odd: SKIP (0.000s)
[615.151884] [118/156] (442s left) kms_pm_rpm (drm-resources-equal)
[616.980226] Starting subtest: drm-resources-equal
[622.057043] Subtest drm-resources-equal: SUCCESS (5.079s)
[622.146864] [119/156] (435s left) gem_ctx_param (non-root-set)
[622.198588] Starting subtest: non-root-set
[622.223268] Subtest non-root-set: SUCCESS (0.025s)
[622.319403] [120/156] (435s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[622.420915] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[622.446164] Starting dynamic subtest: pipe-A-plane-0
[622.737069] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[622.750099] Starting dynamic subtest: pipe-A-plane-3
[622.968259] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[622.978929] Starting dynamic subtest: pipe-A-plane-5
[622.983604] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[624.059536] Starting dynamic subtest: pipe-B-plane-0
[624.351672] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[624.364636] Starting dynamic subtest: pipe-B-plane-3
[624.584405] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s)
[624.598439] Starting dynamic subtest: pipe-B-plane-5
[624.603016] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[624.896234] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.475s)
[625.715708] [121/156] (432s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[625.822142] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[625.826219] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[625.942425] [122/156] (431s left) gem_exec_basic (basic)
[625.993192] Starting subtest: basic
[625.995501] Starting dynamic subtest: rcs0-smem
[625.997911] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[626.010197] Starting dynamic subtest: bcs0-smem
[626.012473] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[626.023076] Starting dynamic subtest: vcs0-smem
[626.025092] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[626.035082] Starting dynamic subtest: vcs1-smem
[626.037116] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[626.047106] Starting dynamic subtest: vecs0-smem
[626.049114] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[626.059028] Starting dynamic subtest: ccs0-smem
[626.060998] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[626.062976] Subtest basic: SUCCESS (0.020s)
[627.923488] [123/156] (429s left) gem_pxp (hw-rejects-pxp-context)
[628.055584] Starting subtest: hw-rejects-pxp-context
[628.060798] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[628.175349] [124/156] (429s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[628.277345] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[628.281529] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[628.392841] [125/156] (429s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[628.936007] Starting subtest: syncobj-timeline-multiple-ext-nodes
[628.938634] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[629.931949] [126/156] (428s left) kms_cursor_edge_walk (256x256-top-edge)
[630.021856] Starting subtest: 256x256-top-edge
[630.023975] Starting dynamic subtest: pipe-A-eDP-1
[633.550781] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.528s)
[633.562388] Starting dynamic subtest: pipe-D-eDP-1
[636.723978] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.170s)
[636.726229] Subtest 256x256-top-edge: SUCCESS (6.701s)
[637.616122] [127/156] (420s left) syncobj_timeline (wait-for-submit-snapshot)
[637.680214] Starting subtest: wait-for-submit-snapshot
[637.760704] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[637.852982] [128/156] (420s left) gem_basic (multigpu-create-close)
[637.904162] Starting subtest: multigpu-create-close
[637.908642] Subtest multigpu-create-close: SKIP (0.000s)
[638.011681] [129/156] (420s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[638.105747] Starting subtest: primary-yf-tiled-reflect-x-270
[638.110381] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[638.207081] [130/156] (419s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[638.310580] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[639.323189] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.013s)
[639.449963] [131/156] (418s left) kms_cursor_crc (cursor-random-max-size)
[639.758735] Starting subtest: cursor-random-max-size
[639.763994] Subtest cursor-random-max-size: SKIP (0.000s)
[639.895317] [132/156] (418s left) kms_psr (psr-sprite-plane-move)
[639.989170] Starting subtest: psr-sprite-plane-move
[639.992021] Starting dynamic subtest: eDP-1
[641.702003] Dynamic subtest eDP-1: SUCCESS (1.714s)
[641.704368] Subtest psr-sprite-plane-move: SUCCESS (1.715s)
[642.522131] [133/156] (415s left) kms_plane_alpha_blend (alpha-basic)
[642.623048] Starting subtest: alpha-basic
[642.912697] Starting dynamic subtest: pipe-A-eDP-1
[644.859427] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[644.891755] Starting dynamic subtest: pipe-D-eDP-1
[647.567329] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.686s)
[647.569786] Subtest alpha-basic: SUCCESS (4.947s)
[648.407997] [134/156] (409s left) gem_exec_params (no-bsd)
[648.471168] Starting subtest: no-bsd
[648.473620] Subtest no-bsd: SUCCESS (0.002s)
[649.898736] [135/156] (408s left) vgem_basic (create)
[649.947037] Starting subtest: create
[649.949259] Subtest create: SUCCESS (0.000s)
[650.005335] [136/156] (408s left) kms_hdr (invalid-metadata-sizes)
[650.107763] Starting subtest: invalid-metadata-sizes
[650.109903] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[650.113803] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[650.125234] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[650.129616] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[650.134013] Subtest invalid-metadata-sizes: SKIP (0.003s)
[650.182029] [137/156] (408s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[650.279915] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[650.282149] Starting dynamic subtest: pipe-A-eDP-1
[650.376966] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[650.389125] Starting dynamic subtest: pipe-B-eDP-1
[651.556209] Dynamic subtest pipe-B-eDP-1: SKIP (1.176s)
[651.560880] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.279s)
[652.808068] [138/156] (405s left) sw_sync (sync_merge)
[652.843547] Starting subtest: sync_merge
[652.845940] Subtest sync_merge: SUCCESS (0.000s)
[652.893867] [139/156] (405s left) syncobj_wait (single-wait-all-signaled)
[652.948743] Starting subtest: single-wait-all-signaled
[652.950658] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[653.038090] [140/156] (405s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[653.157057] Starting subtest: cursor-vs-flip-varying-size
[684.385042] Subtest cursor-vs-flip-varying-size: SUCCESS (31.230s)
[685.191412] [141/156] (373s left) kms_vrr (negative-basic)
[685.289588] Starting subtest: negative-basic
[685.296012] Starting dynamic subtest: pipe-A-eDP-1
[690.713797] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s)
[691.026126] Subtest negative-basic: SUCCESS (5.738s)
[691.899371] [142/156] (366s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[691.991761] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[691.996114] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[692.087906] [143/156] (366s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[692.186950] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[692.276222] [144/156] (366s left) gem_ctx_exec (basic)
[692.335094] Starting subtest: basic
[692.340191] Subtest basic: SUCCESS (0.006s)
[692.452994] [145/156] (366s left) perf_pmu (event-wait)
[692.493250] Starting subtest: event-wait
[692.495624] Starting dynamic subtest: rcs0
[692.499902] Dynamic subtest rcs0: SKIP (0.000s)
[692.503911] Subtest event-wait: SKIP (0.001s)
[692.620324] [146/156] (366s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[692.731702] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[692.735850] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[692.830437] [147/156] (366s left) api_intel_allocator (fork-simple-stress-signal)
[692.890755] Starting subtest: fork-simple-stress-signal
[698.291654] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[698.426286] [148/156] (360s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[698.485427] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[698.590130] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[698.672535] [149/156] (360s left) kms_atomic (plane-overlay-legacy)
[698.774500] Starting subtest: plane-overlay-legacy
[698.776824] Starting dynamic subtest: pipe-A-eDP-1
[699.176085] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[699.178380] Subtest plane-overlay-legacy: SUCCESS (0.400s)
[699.992933] [150/156] (359s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[700.104965] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[707.432130] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.333s)
[707.578929] [151/156] (351s left) kms_flip (flip-vs-wf_vblank-interruptible)
[707.678411] Starting subtest: flip-vs-wf_vblank-interruptible
[707.680823] Starting dynamic subtest: A-eDP1
[709.605603] Dynamic subtest A-eDP1: SUCCESS (1.926s)
[709.616139] Starting dynamic subtest: B-eDP1
[711.503679] Dynamic subtest B-eDP1: SUCCESS (1.896s)
[711.517996] Starting dynamic subtest: C-eDP1
[713.392286] Dynamic subtest C-eDP1: SUCCESS (1.887s)
[713.408012] Starting dynamic subtest: D-eDP1
[715.295724] Dynamic subtest D-eDP1: SUCCESS (1.901s)
[715.300699] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.625s)
[716.486691] [152/156] (342s left) gem_exec_schedule (u-independent)
[716.556006] Starting subtest: u-independent
[716.557977] Starting dynamic subtest: rcs0
[717.865780] Dynamic subtest rcs0: SUCCESS (1.319s)
[717.880548] Starting dynamic subtest: vcs0
[719.858807] Dynamic subtest vcs0: SUCCESS (1.991s)
[719.871632] Starting dynamic subtest: vcs1
[721.857477] Dynamic subtest vcs1: SUCCESS (1.996s)
[721.871282] Starting dynamic subtest: vecs0
[723.842456] Dynamic subtest vecs0: SUCCESS (1.982s)
[723.858514] Starting dynamic subtest: ccs0
[725.866518] Dynamic subtest ccs0: SUCCESS (2.022s)
[725.869611] Subtest u-independent: SUCCESS (9.323s)
[726.176647] [153/156] (332s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[726.283432] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[726.287881] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[726.371994] [154/156] (332s left) gem_mmap (bad-offset)
[726.426645] Subtest bad-offset: SKIP (0.000s)
[726.499836] [155/156] (332s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[726.594149] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[726.598181] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[726.696310] [156/156] (332s left) gem_ctx_param (invalid-set-no-zeromap)
[726.743640] Starting subtest: invalid-set-no-zeromap
[726.746004] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[726.818274] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: i915_drm_fdinfo
results: parsing output: 3/ for test: kms_lease
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_flip_event_leak
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: gem_ctx_shared
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_chamelium_color
results: parsing output: 18/ for test: i915_module_load
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_balancer
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_fence_thrash
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: dmabuf
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: syncobj_basic
results: parsing output: 30/ for test: gem_exec_params
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: gem_close_race
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: i915_pm_rps
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: i915_pm_rc6_residency
results: parsing output: 54/ for test: gem_exec_parallel
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_setmode
results: parsing output: 57/ for test: prime_mmap_kms
results: parsing output: 58/ for test: kms_chamelium_frames
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: kms_color
results: parsing output: 65/ for test: kms_hdmi_inject
results: parsing output: 66/ for test: perf
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: sysfs_heartbeat_interval
results: parsing output: 78/ for test: core_getclient
results: parsing output: 79/ for test: kms_setmode
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_params
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: syncobj_basic
results: parsing output: 88/ for test: gem_exec_schedule
results: parsing output: 89/ for test: kms_pm_backlight
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_debugfs
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: prime_vgem
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_caching
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: kms_universal_plane
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: gem_exec_store
results: parsing output: 113/ for test: prime_mmap_coherency
results: parsing output: 114/ for test: gem_lmem_swapping
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_ctx_param
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_exec_basic
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_fence
results: parsing output: 125/ for test: kms_cursor_edge_walk
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_basic
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_plane_alpha_blend
results: parsing output: 133/ for test: gem_exec_params
results: parsing output: 134/ for test: vgem_basic
results: parsing output: 135/ for test: kms_hdr
results: parsing output: 136/ for test: kms_psr2_sf
results: parsing output: 137/ for test: sw_sync
results: parsing output: 138/ for test: syncobj_wait
results: parsing output: 139/ for test: kms_cursor_legacy
results: parsing output: 140/ for test: kms_vrr
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_addfb_basic
results: parsing output: 143/ for test: gem_ctx_exec
results: parsing output: 144/ for test: perf_pmu
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: api_intel_allocator
results: parsing output: 147/ for test: syncobj_timeline
results: parsing output: 148/ for test: kms_atomic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_flip
results: parsing output: 151/ for test: gem_exec_schedule
results: parsing output: 152/ for test: kms_big_fb
results: parsing output: 153/ for test: gem_mmap
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_ctx_param
Done.