[61.074181] Initializing watchdogs
[61.074229]   /dev/watchdog0
[61.088537] [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]
[61.092698] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.094945] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.098522] [001/133] (960s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[61.237601] Starting subtest: psr2-overlay-plane-update-continuous-sf
[61.239918] Starting dynamic subtest: pipe-A-eDP-1
[62.382804] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.142s)
[62.390913] Starting dynamic subtest: pipe-B-eDP-1
[64.148300] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.755s)
[64.150895] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.900s)
[64.974606] [002/133] (956s left) i915_drm_fdinfo (memory-info-resident)
[65.019327] Starting subtest: memory-info-resident
[65.021617] Starting dynamic subtest: smem0
[68.104118] Dynamic subtest smem0: SUCCESS (3.073s)
[68.106976] Subtest memory-info-resident: SUCCESS (3.074s)
[68.178823] [003/133] (953s left) gem_exec_schedule (preempt-contexts)
[68.268109] Starting subtest: preempt-contexts
[68.270477] Starting dynamic subtest: rcs0
[68.351938] Dynamic subtest rcs0: SUCCESS (0.086s)
[68.361891] Starting dynamic subtest: bcs0
[68.434938] Dynamic subtest bcs0: SUCCESS (0.082s)
[68.444281] Starting dynamic subtest: vcs0
[68.505380] Dynamic subtest vcs0: SUCCESS (0.070s)
[68.513236] Starting dynamic subtest: vcs1
[68.569461] Dynamic subtest vcs1: SUCCESS (0.064s)
[68.579569] Starting dynamic subtest: vecs0
[68.635176] Dynamic subtest vecs0: SUCCESS (0.065s)
[68.645433] Starting dynamic subtest: ccs0
[68.709485] Dynamic subtest ccs0: SUCCESS (0.073s)
[68.711946] Subtest preempt-contexts: SUCCESS (0.443s)
[70.010341] [004/133] (951s left) gem_lmem_swapping (basic)
[70.059702] Subtest basic: SKIP (0.000s)
[70.104349] [005/133] (951s left) kms_cursor_crc (cursor-onscreen-128x128)
[70.308648] Starting subtest: cursor-onscreen-128x128
[70.313764] Starting dynamic subtest: pipe-A-eDP-1
[72.453100] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.137s)
[72.484610] Starting dynamic subtest: pipe-D-eDP-1
[75.277920] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[75.280357] Subtest cursor-onscreen-128x128: SUCCESS (4.960s)
[76.069327] [006/133] (945s left) kms_vrr (seamless-rr-switch-drrs)
[76.173986] Starting subtest: seamless-rr-switch-drrs
[76.180676] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[76.245140] [007/133] (945s left) gem_mmap_gtt (pf-nonblock)
[76.307577] Subtest pf-nonblock: SKIP (0.000s)
[76.356356] [008/133] (945s left) kms_psr (pr-basic)
[76.440684] Starting subtest: pr-basic
[76.445187] Subtest pr-basic: SKIP (0.000s)
[76.510631] [009/133] (945s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[76.590854] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[76.595334] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[76.661611] [010/133] (945s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[76.753691] Starting subtest: pr-primary-plane-update-sf-dmg-area
[76.757804] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[76.831757] [011/133] (945s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[76.918812] Starting subtest: primary-y-tiled-reflect-x-90
[76.923064] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[76.993295] [012/133] (945s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[77.093205] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[77.097122] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[78.203658] [013/133] (943s left) gem_exec_schedule (thriceslice)
[78.273964] Starting subtest: thriceslice
[78.276113] Starting dynamic subtest: rcs0
[78.291460] Dynamic subtest rcs0: SUCCESS (0.029s)
[78.301301] Starting dynamic subtest: bcs0
[78.340146] Dynamic subtest bcs0: SUCCESS (0.048s)
[78.350248] Starting dynamic subtest: vcs0
[78.391991] Dynamic subtest vcs0: SUCCESS (0.051s)
[78.402108] Starting dynamic subtest: vcs1
[78.421562] Dynamic subtest vcs1: SUCCESS (0.029s)
[78.430514] Starting dynamic subtest: vecs0
[78.449823] Dynamic subtest vecs0: SUCCESS (0.028s)
[78.457925] Starting dynamic subtest: ccs0
[78.502062] Dynamic subtest ccs0: SUCCESS (0.051s)
[78.504730] Subtest thriceslice: SUCCESS (0.241s)
[78.813224] [014/133] (943s left) kms_psr (psr-cursor-plane-onoff)
[78.911694] Starting subtest: psr-cursor-plane-onoff
[78.914062] Starting dynamic subtest: eDP-1
[80.599964] Dynamic subtest eDP-1: SUCCESS (1.686s)
[80.602427] Subtest psr-cursor-plane-onoff: SUCCESS (1.687s)
[81.470845] [015/133] (940s left) syncobj_timeline (device-submit-unordered)
[81.535091] Starting subtest: device-submit-unordered
[81.537524] Subtest device-submit-unordered: SUCCESS (0.001s)
[81.644015] [016/133] (940s left) gem_softpin (allocator-evict)
[81.701389] Starting subtest: allocator-evict
[81.703817] Starting dynamic subtest: rcs0
[105.037453] Dynamic subtest rcs0: SUCCESS (23.322s)
[105.047992] Starting dynamic subtest: bcs0
[128.960655] Dynamic subtest bcs0: SUCCESS (23.918s)
[128.968380] Starting dynamic subtest: vcs0
[152.747910] Dynamic subtest vcs0: SUCCESS (23.785s)
[152.756208] Starting dynamic subtest: vcs1
[176.410368] Dynamic subtest vcs1: SUCCESS (23.661s)
[176.421029] Starting dynamic subtest: vecs0
[200.281767] Dynamic subtest vecs0: SUCCESS (23.869s)
[200.291486] Starting dynamic subtest: ccs0
[224.011028] Dynamic subtest ccs0: SUCCESS (23.727s)
[224.013359] Subtest allocator-evict: SUCCESS (142.286s)
[224.090081] [017/133] (798s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[224.236249] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[224.609491] Starting dynamic subtest: pipe-A-eDP-1
[227.347047] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s)
[227.711255] Starting dynamic subtest: pipe-B-eDP-1
[230.479080] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.773s)
[230.840083] Starting dynamic subtest: pipe-C-eDP-1
[233.611559] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[233.969751] Starting dynamic subtest: pipe-D-eDP-1
[236.738788] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[236.741098] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.502s)
[237.919578] [018/133] (784s left) kms_sequence (queue-idle)
[238.032238] Starting subtest: queue-idle
[238.034691] Starting dynamic subtest: pipe-A-eDP-1
[239.835771] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s)
[239.845584] Starting dynamic subtest: pipe-B-eDP-1
[242.290849] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.455s)
[242.300853] Starting dynamic subtest: pipe-C-eDP-1
[244.712758] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.420s)
[244.722339] Starting dynamic subtest: pipe-D-eDP-1
[247.135177] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[247.137434] Subtest queue-idle: SUCCESS (9.100s)
[247.953341] [019/133] (774s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[248.065676] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[252.334029] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.270s)
[253.453782] [020/133] (768s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[253.577768] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[254.569760] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.992s)
[255.378076] [021/133] (766s left) gen7_exec_parse (chained-batch)
[255.451062] Subtest chained-batch: SKIP (0.000s)
[255.551033] [022/133] (766s left) syncobj_timeline (invalid-signal-zero-handles)
[255.617036] Starting subtest: invalid-signal-zero-handles
[255.619411] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[255.732150] [023/133] (766s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[255.847026] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[256.431857] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.592s)
[256.636802] [024/133] (765s left) gem_exec_nop (basic-sequential)
[256.712709] Starting subtest: basic-sequential
[271.369278] Subtest basic-sequential: SUCCESS (14.663s)
[271.583988] [025/133] (750s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[271.670703] Starting subtest: coverage-vs-premult-vs-constant
[271.948163] Starting dynamic subtest: pipe-A-eDP-1
[272.520290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[272.528645] Starting dynamic subtest: pipe-D-eDP-1
[273.796318] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.273s)
[273.798261] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.125s)
[274.638606] [026/133] (747s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[274.733062] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[274.735304] Starting dynamic subtest: pipe-A
[274.798519] Dynamic subtest pipe-A: SUCCESS (0.066s)
[274.808100] Starting dynamic subtest: pipe-B
[275.959534] Dynamic subtest pipe-B: SUCCESS (1.161s)
[275.969336] Starting dynamic subtest: pipe-C
[277.068269] Dynamic subtest pipe-C: SUCCESS (1.108s)
[277.076145] Starting dynamic subtest: pipe-D
[278.205111] Dynamic subtest pipe-D: SUCCESS (1.136s)
[278.207574] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.473s)
[279.369442] [027/133] (743s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[279.441045] Starting subtest: multi-wait-available-unsubmitted-submitted
[279.443424] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[279.547337] [028/133] (743s left) i915_hangman (engine-error-state-capture)
[279.619776] Starting subtest: engine-error-state-capture
[279.622854] Starting dynamic subtest: rcs0
[282.866924] Dynamic subtest rcs0: SUCCESS (3.246s)
[282.880459] Starting dynamic subtest: bcs0
[288.884627] Dynamic subtest bcs0: SUCCESS (6.015s)
[288.902965] Starting dynamic subtest: vcs0
[294.836693] Dynamic subtest vcs0: SUCCESS (5.950s)
[294.848048] Starting dynamic subtest: vcs1
[299.892535] Dynamic subtest vcs1: SUCCESS (5.054s)
[299.904654] Starting dynamic subtest: vecs0
[305.844588] Dynamic subtest vecs0: SUCCESS (5.951s)
[305.855799] Starting dynamic subtest: ccs0
[311.860436] Dynamic subtest ccs0: SUCCESS (6.014s)
[311.863408] Subtest engine-error-state-capture: SUCCESS (32.240s)
[311.936388] [029/133] (710s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[312.011417] Starting subtest: wait-all-for-submit-delayed-submit
[312.114611] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[312.211351] [030/133] (710s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[312.344273] Starting subtest: short-flip-before-cursor-atomic-transitions
[313.312684] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.967s)
[314.110262] [031/133] (708s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[314.171863] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[314.174232] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[314.278967] [032/133] (708s left) sysfs_heartbeat_interval (nopreempt)
[314.341892] Starting subtest: nopreempt
[314.344178] Starting dynamic subtest: vecs0
[322.898739] Dynamic subtest vecs0: SUCCESS (8.555s)
[322.912128] Starting dynamic subtest: ccs0
[326.836832] Dynamic subtest ccs0: SUCCESS (3.939s)
[326.847853] Starting dynamic subtest: vcs0
[336.918227] Dynamic subtest vcs0: SUCCESS (10.078s)
[336.928396] Starting dynamic subtest: bcs0
[340.811573] Dynamic subtest bcs0: SUCCESS (3.893s)
[340.822282] Starting dynamic subtest: rcs0
[344.828687] Dynamic subtest rcs0: SUCCESS (4.016s)
[344.839531] Starting dynamic subtest: vcs1
[353.874984] Dynamic subtest vcs1: SUCCESS (9.043s)
[353.877867] Subtest nopreempt: SUCCESS (39.531s)
[353.946280] [033/133] (668s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[354.052734] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[354.057110] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[354.147291] [034/133] (668s left) kms_psr (psr-sprite-plane-move)
[354.240263] Starting subtest: psr-sprite-plane-move
[354.242573] Starting dynamic subtest: eDP-1
[356.049542] Dynamic subtest eDP-1: SUCCESS (1.810s)
[356.051944] Subtest psr-sprite-plane-move: SUCCESS (1.811s)
[356.885347] [035/133] (666s left) kms_psr (fbc-psr-sprite-plane-onoff)
[356.981183] Starting subtest: fbc-psr-sprite-plane-onoff
[356.983565] Starting dynamic subtest: eDP-1
[356.988093] Dynamic subtest eDP-1: SKIP (0.000s)
[356.992580] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[357.052267] [036/133] (665s left) perf_pmu (all-busy-check-all)
[357.099400] Starting subtest: all-busy-check-all
[358.870507] Subtest all-busy-check-all: SUCCESS (1.770s)
[358.989365] [037/133] (664s left) dmabuf_sync_file (export-before-signal)
[359.131968] Starting subtest: export-before-signal
[359.134365] Subtest export-before-signal: SUCCESS (0.002s)
[359.193582] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[359.196772] [038/133] (663s left) gem_exec_reloc (basic-gtt-read-active)
[359.259987] Subtest basic-gtt-read-active: SKIP (0.000s)
[359.324442] [039/133] (663s left) kms_vrr (flip-basic-fastset)
[359.415118] Starting subtest: flip-basic-fastset
[359.421871] Subtest flip-basic-fastset: SKIP (0.000s)
[359.494777] [040/133] (663s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[359.582980] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[359.585351] Starting dynamic subtest: pipe-A
[360.698405] Dynamic subtest pipe-A: SUCCESS (1.118s)
[360.706852] Starting dynamic subtest: pipe-B
[362.854162] Dynamic subtest pipe-B: SUCCESS (2.155s)
[362.861982] Starting dynamic subtest: pipe-C
[364.072068] Dynamic subtest pipe-C: SUCCESS (1.217s)
[364.080797] Starting dynamic subtest: pipe-D
[365.300021] Dynamic subtest pipe-D: SUCCESS (1.227s)
[365.302289] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.720s)
[366.490863] [041/133] (656s left) kms_color (ctm-max)
[366.583776] Starting subtest: ctm-max
[366.586051] Starting dynamic subtest: pipe-A-eDP-1
[367.281631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s)
[367.290985] Starting dynamic subtest: pipe-B-eDP-1
[368.708151] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[368.717577] Starting dynamic subtest: pipe-C-eDP-1
[370.097067] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.389s)
[370.106424] Starting dynamic subtest: pipe-D-eDP-1
[371.422301] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[371.424604] Subtest ctm-max: SUCCESS (4.839s)
[372.221912] [042/133] (650s left) gem_userptr_blits (nohangcheck)
[372.296781] Starting subtest: nohangcheck
[372.555885] Subtest nohangcheck: SUCCESS (0.255s)
[372.667478] [043/133] (650s left) gen3_render_tiledx_blits
[372.769143] [044/133] (650s left) kms_plane_cursor (overlay)
[372.859215] Starting subtest: overlay
[372.863954] Starting dynamic subtest: pipe-A-eDP-1-size-64
[375.338763] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.480s)
[375.399437] Starting dynamic subtest: pipe-A-eDP-1-size-128
[377.796067] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.404s)
[377.855645] Starting dynamic subtest: pipe-A-eDP-1-size-256
[380.296768] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.449s)
[380.646260] Starting dynamic subtest: pipe-B-eDP-1-size-64
[383.766171] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.129s)
[383.826617] Starting dynamic subtest: pipe-B-eDP-1-size-128
[386.333941] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[386.393671] Starting dynamic subtest: pipe-B-eDP-1-size-256
[388.890878] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s)
[389.237910] Starting dynamic subtest: pipe-C-eDP-1-size-64
[392.078590] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.851s)
[392.114787] Starting dynamic subtest: pipe-C-eDP-1-size-128
[394.201035] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.091s)
[394.238207] Starting dynamic subtest: pipe-C-eDP-1-size-256
[396.323874] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.091s)
[396.663965] Starting dynamic subtest: pipe-D-eDP-1-size-64
[399.570264] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.917s)
[399.608946] Starting dynamic subtest: pipe-D-eDP-1-size-128
[401.681311] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.081s)
[401.718842] Starting dynamic subtest: pipe-D-eDP-1-size-256
[403.793721] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.080s)
[404.132918] Subtest overlay: SUCCESS (31.272s)
[404.935251] [045/133] (618s left) perf_pmu (enable-race)
[404.978475] Starting subtest: enable-race
[404.980739] Starting dynamic subtest: rcs0
[417.748134] Dynamic subtest rcs0: SUCCESS (12.769s)
[417.757266] Starting dynamic subtest: bcs0
[430.490968] Dynamic subtest bcs0: SUCCESS (12.740s)
[430.499713] Starting dynamic subtest: vcs0
[445.845989] Dynamic subtest vcs0: SUCCESS (15.350s)
[445.856065] Starting dynamic subtest: vcs1
[461.910418] Dynamic subtest vcs1: SUCCESS (16.060s)
[461.921045] Starting dynamic subtest: vecs0
[477.930415] Dynamic subtest vecs0: SUCCESS (15.995s)
[477.939068] Starting dynamic subtest: ccs0
[490.665258] Dynamic subtest ccs0: SUCCESS (12.754s)
[490.668210] Subtest enable-race: SUCCESS (85.681s)
[490.768511] [046/133] (532s left) kms_feature_discovery (display-2x)
[490.858098] Starting subtest: display-2x
[490.862702] Subtest display-2x: SKIP (0.000s)
[490.932620] [047/133] (532s left) gem_exec_reloc (basic-wc-gtt-active)
[490.986608] Subtest basic-wc-gtt-active: SKIP (0.000s)
[491.051460] [048/133] (532s left) gem_ctx_isolation (dirty-switch)
[491.106762] Starting subtest: dirty-switch
[491.108654] Starting dynamic subtest: rcs0
[491.295692] Dynamic subtest rcs0: SUCCESS (0.191s)
[491.306069] Starting dynamic subtest: bcs0
[491.503464] Dynamic subtest bcs0: SUCCESS (0.207s)
[491.513291] Starting dynamic subtest: vcs0
[491.707693] Dynamic subtest vcs0: SUCCESS (0.204s)
[491.717239] Starting dynamic subtest: vcs1
[493.071347] Dynamic subtest vcs1: SUCCESS (1.362s)
[493.082513] Starting dynamic subtest: vecs0
[495.069843] Dynamic subtest vecs0: SUCCESS (1.997s)
[495.080492] Starting dynamic subtest: ccs0
[497.144388] Dynamic subtest ccs0: SUCCESS (2.072s)
[497.146896] Subtest dirty-switch: SUCCESS (6.039s)
[497.366788] [049/133] (526s left) gem_render_copy (linear)
[497.430431] Starting subtest: linear
[497.433082] Starting dynamic subtest: smem
[497.474048] Dynamic subtest smem: SUCCESS (0.044s)
[497.476624] Subtest linear: SUCCESS (0.044s)
[497.748868] [050/133] (525s left) vgem_slow (nohang)
[497.804206] Starting subtest: nohang
[508.019106] Subtest nohang: SUCCESS (10.214s)
[508.088073] [051/133] (515s left) kms_flip (busy-flip)
[508.189061] Starting subtest: busy-flip
[508.191516] Starting dynamic subtest: A-eDP1
[509.850023] Dynamic subtest A-eDP1: SUCCESS (1.663s)
[509.861128] Starting dynamic subtest: B-eDP1
[511.482190] Dynamic subtest B-eDP1: SUCCESS (1.631s)
[511.493522] Starting dynamic subtest: C-eDP1
[513.102658] Dynamic subtest C-eDP1: SUCCESS (1.618s)
[513.111455] Starting dynamic subtest: D-eDP1
[514.734707] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[514.740552] Subtest busy-flip: SUCCESS (6.555s)
[515.904540] [052/133] (507s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[516.004912] Starting subtest: fbcpsr-rgb101010-draw-render
[522.766205] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.765s)
[522.900230] [053/133] (500s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[523.463864] Starting subtest: syncobj-timeline-invalid-flags
[523.466567] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[524.975320] [054/133] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[525.075503] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[531.751585] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.680s)
[531.880092] [055/133] (491s left) syncobj_wait (multi-wait-signaled)
[531.932752] Starting subtest: multi-wait-signaled
[531.935141] Subtest multi-wait-signaled: SUCCESS (0.000s)
[532.029512] [056/133] (491s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[532.122091] Starting subtest: invalid-modeset-force-ultra-joiner
[532.126731] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[532.203324] [057/133] (491s left) syncobj_timeline (signal-array)
[532.255085] Starting subtest: signal-array
[532.257415] Subtest signal-array: SUCCESS (0.000s)
[532.348529] [058/133] (491s left) kms_flip (bo-too-big)
[532.446234] Starting subtest: bo-too-big
[532.448500] Starting dynamic subtest: A-eDP1
[533.776823] Dynamic subtest A-eDP1: SUCCESS (1.330s)
[533.788246] Starting dynamic subtest: B-eDP1
[535.099618] Dynamic subtest B-eDP1: SUCCESS (1.320s)
[535.111796] Starting dynamic subtest: C-eDP1
[536.427773] Dynamic subtest C-eDP1: SUCCESS (1.326s)
[536.438956] Starting dynamic subtest: D-eDP1
[537.746426] Dynamic subtest D-eDP1: SUCCESS (1.318s)
[537.748878] Subtest bo-too-big: SUCCESS (5.304s)
[538.959693] [059/133] (485s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[539.017021] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[539.021278] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[539.206658] [060/133] (484s left) syncobj_wait (invalid-signal-one-illegal-handle)
[539.257032] Starting subtest: invalid-signal-one-illegal-handle
[539.259335] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[539.346879] [061/133] (484s left) gem_eio (kms)
[539.606996] Starting subtest: kms
[559.232264] Subtest kms: SUCCESS (19.625s)
[560.424126] [062/133] (463s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[560.534366] Starting subtest: fbc-psr2-cursor-plane-onoff
[560.536726] Starting dynamic subtest: eDP-1
[560.541241] Dynamic subtest eDP-1: SKIP (0.000s)
[560.545701] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[560.609082] [063/133] (463s left) kms_flip (2x-blocking-wf_vblank)
[560.694220] Starting subtest: 2x-blocking-wf_vblank
[560.702773] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[560.781187] [064/133] (463s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[560.870616] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[560.874770] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[560.968215] [065/133] (463s left) sw_sync (sync_merge_same)
[561.008394] Starting subtest: sync_merge_same
[561.010763] Subtest sync_merge_same: SUCCESS (0.000s)
[561.065951] [066/133] (463s left) gem_request_retire (retire-vma-not-inactive)
[561.126615] Starting subtest: retire-vma-not-inactive
[561.186137] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[561.307480] [067/133] (462s left) kms_addfb_basic (unused-handle)
[561.363830] Starting subtest: unused-handle
[561.365846] Subtest unused-handle: SUCCESS (0.000s)
[561.499849] [068/133] (462s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[561.594567] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[561.596546] Starting dynamic subtest: pipe-A-eDP-1
[561.616710] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[561.630700] Starting dynamic subtest: pipe-B-eDP-1
[561.649107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[561.662743] Starting dynamic subtest: pipe-C-eDP-1
[561.681254] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[561.694274] Starting dynamic subtest: pipe-D-eDP-1
[561.713889] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[561.717473] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.006s)
[563.864462] [069/133] (460s left) kms_plane (pixel-format-linear-modifier)
[563.954852] Starting subtest: pixel-format-linear-modifier
[563.981332] Starting dynamic subtest: pipe-A-plane-0
[567.814226] Dynamic subtest pipe-A-plane-0: SUCCESS (3.833s)
[567.822951] Starting dynamic subtest: pipe-A-plane-3
[569.569968] Dynamic subtest pipe-A-plane-3: SUCCESS (1.755s)
[569.580567] Starting dynamic subtest: pipe-A-plane-5
[569.780996] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[570.850770] Starting dynamic subtest: pipe-B-plane-0
[574.642868] Dynamic subtest pipe-B-plane-0: SUCCESS (3.800s)
[574.653576] Starting dynamic subtest: pipe-B-plane-3
[576.387747] Dynamic subtest pipe-B-plane-3: SUCCESS (1.742s)
[576.398291] Starting dynamic subtest: pipe-B-plane-5
[576.598488] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[576.909968] Subtest pixel-format-linear-modifier: SUCCESS (12.956s)
[577.715758] [070/133] (446s left) gem_basic (create-fd-close)
[577.781876] Starting subtest: create-fd-close
[577.786684] Subtest create-fd-close: SUCCESS (0.000s)
[577.883093] [071/133] (446s left) sriov_basic (enable-vfs-bind-unbind-each)
[577.948931] Starting subtest: enable-vfs-bind-unbind-each
[577.951266] Starting dynamic subtest: numvfs-1
[578.028720] Dynamic subtest numvfs-1: FAIL (0.028s)
[578.038276] Starting dynamic subtest: numvfs-2
[578.107165] Dynamic subtest numvfs-2: FAIL (0.003s)
[578.116389] Starting dynamic subtest: numvfs-3
[578.188728] Dynamic subtest numvfs-3: FAIL (0.003s)
[578.199268] Starting dynamic subtest: numvfs-4
[578.270498] Dynamic subtest numvfs-4: FAIL (0.003s)
[578.280612] Starting dynamic subtest: numvfs-5
[578.353048] Dynamic subtest numvfs-5: FAIL (0.003s)
[578.362732] Starting dynamic subtest: numvfs-6
[578.434603] Dynamic subtest numvfs-6: FAIL (0.003s)
[578.445295] Starting dynamic subtest: numvfs-7
[578.517779] Dynamic subtest numvfs-7: FAIL (0.003s)
[578.527481] Starting dynamic subtest: numvfs-random
[578.599378] Dynamic subtest numvfs-random: FAIL (0.003s)
[578.601419] Subtest enable-vfs-bind-unbind-each: FAIL (0.057s)
[578.640420] [072/133] (445s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[578.750475] Starting subtest: yf-tiled-64bpp-rotate-180
[578.754214] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[578.858857] [073/133] (445s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[578.945188] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[578.946877] Starting dynamic subtest: A-eDP1
[582.525150] Dynamic subtest A-eDP1: SUCCESS (3.577s)
[582.534950] Starting dynamic subtest: B-eDP1
[585.728657] Dynamic subtest B-eDP1: SUCCESS (3.200s)
[585.738181] Starting dynamic subtest: C-eDP1
[588.805617] Dynamic subtest C-eDP1: SUCCESS (3.076s)
[588.815878] Starting dynamic subtest: D-eDP1
[591.911219] Dynamic subtest D-eDP1: SUCCESS (3.104s)
[591.913474] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.966s)
[592.708606] [074/133] (431s left) prime_mmap_coherency (read)
[592.761722] Starting subtest: read
[598.137439] Subtest read: SUCCESS (5.373s)
[598.273223] [075/133] (426s left) kms_force_connector_basic (force-load-detect)
[598.352856] Starting subtest: force-load-detect
[598.357691] Subtest force-load-detect: SKIP (0.000s)
[598.484946] [076/133] (426s left) kms_cursor_edge_walk (128x128-top-edge)
[598.575929] Starting subtest: 128x128-top-edge
[598.578274] Starting dynamic subtest: pipe-A-eDP-1
[602.092601] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.516s)
[602.101723] Starting dynamic subtest: pipe-D-eDP-1
[605.212595] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[605.214807] Subtest 128x128-top-edge: SUCCESS (6.636s)
[606.017265] [077/133] (418s left) kms_prop_blob (blob-prop-lifetime)
[606.072147] Starting subtest: blob-prop-lifetime
[606.074466] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[606.170730] [078/133] (418s left) gem_close (basic)
[606.234854] Starting subtest: basic
[606.237051] Subtest basic: SUCCESS (0.000s)
[606.328087] [079/133] (418s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[606.430615] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs
[606.432719] Starting dynamic subtest: pipe-A-eDP-1
[606.839688] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.410s)
[606.849226] Starting dynamic subtest: pipe-B-eDP-1
[606.869803] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[606.879351] Starting dynamic subtest: pipe-C-eDP-1
[606.896518] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[606.905178] Starting dynamic subtest: pipe-D-eDP-1
[606.921889] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[606.923770] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.424s)
[609.101536] [080/133] (415s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[609.195924] Starting subtest: psr-indfb-scaledprimary
[614.965087] Subtest psr-indfb-scaledprimary: SUCCESS (5.772s)
[615.082464] [081/133] (409s left) gem_create (hog-create)
[615.138626] Starting subtest: hog-create
[615.140840] Starting dynamic subtest: smem0
[648.924647] Dynamic subtest smem0: SUCCESS (33.783s)
[648.927229] Subtest hog-create: SUCCESS (33.785s)
[649.155548] [082/133] (375s left) gem_tiled_wb
[649.292257] [083/133] (375s left) gem_exec_whisper (basic-contexts)
[649.350756] Starting subtest: basic-contexts
[657.756833] Subtest basic-contexts: SUCCESS (8.401s)
[657.934629] [084/133] (367s left) gem_media_fill (media-fill)
[657.998150] Subtest media-fill: SKIP (0.000s)
[658.115666] [085/133] (366s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[658.216043] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[658.220315] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[658.315109] [086/133] (366s left) gem_eio (hibernate)
[658.552092] Starting subtest: hibernate
[673.225037] Subtest hibernate: SUCCESS (14.669s)
[682.384676] [087/133] (351s left) gem_exec_balancer (semaphore)
[682.468394] Starting subtest: semaphore
[683.919688] Subtest semaphore: SUCCESS (1.449s)
[684.375892] [088/133] (349s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[684.431412] Starting subtest: multi-wait-all-for-submit-submitted
[684.537995] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[684.617367] [089/133] (349s left) gem_ctx_persistence (heartbeat-close)
[684.676483] Starting subtest: heartbeat-close
[684.681200] Subtest heartbeat-close: SKIP (0.000s)
[684.793513] [090/133] (349s left) api_intel_bb (reset-flags)
[684.859336] Starting subtest: reset-flags
[684.870786] Subtest reset-flags: SUCCESS (0.013s)
[684.983555] [091/133] (349s left) vgem_basic (create)
[685.034843] Starting subtest: create
[685.037121] Subtest create: SUCCESS (0.000s)
[685.093987] [092/133] (349s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[685.227300] Starting subtest: x-tiled-32bpp-rotate-180
[686.722280] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.494s)
[686.869858] [093/133] (347s left) prime_mmap (test_refcounting)
[686.926084] Starting subtest: test_refcounting
[686.927922] Starting dynamic subtest: test_refcounting-smem
[686.955035] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[686.957148] Subtest test_refcounting: SUCCESS (0.032s)
[687.047783] [094/133] (347s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[687.134264] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[687.137839] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[687.227371] [095/133] (347s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[687.617214] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[688.406823] [096/133] (346s left) gem_exec_balancer (full-late-pulse)
[688.465527] Starting subtest: full-late-pulse
[692.798821] Subtest full-late-pulse: SUCCESS (4.332s)
[693.101027] [097/133] (341s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[693.228048] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[693.230287] Starting dynamic subtest: pipe-A-eDP-1
[693.239375] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[693.249800] Starting dynamic subtest: pipe-B-eDP-1
[693.258928] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[693.268459] Starting dynamic subtest: pipe-C-eDP-1
[693.277220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[693.286517] Starting dynamic subtest: pipe-D-eDP-1
[693.295181] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[693.299497] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[695.477934] [098/133] (339s left) kms_pm_rpm (basic-pci-d3-state)
[697.104056] Starting subtest: basic-pci-d3-state
[698.675737] Subtest basic-pci-d3-state: SUCCESS (1.571s)
[698.766692] [099/133] (335s left) i915_selftest (mock)
[702.094740] Starting subtest: mock
[702.098023] Starting dynamic subtest: sanitycheck
[702.789792] Dynamic subtest sanitycheck: SUCCESS (0.694s)
[702.800128] Starting dynamic subtest: shmem
[703.453206] Dynamic subtest shmem: SUCCESS (0.661s)
[703.463805] Starting dynamic subtest: fence
[711.045331] Dynamic subtest fence: SUCCESS (7.590s)
[711.055486] Starting dynamic subtest: scatterlist
[712.731328] Dynamic subtest scatterlist: SUCCESS (1.684s)
[712.742254] Starting dynamic subtest: syncmap
[716.126367] Dynamic subtest syncmap: SUCCESS (3.392s)
[716.137082] Starting dynamic subtest: uncore
[716.777223] Dynamic subtest uncore: SUCCESS (0.649s)
[716.787778] Starting dynamic subtest: ring
[717.443071] Dynamic subtest ring: SUCCESS (0.663s)
[717.453833] Starting dynamic subtest: engine
[718.121095] Dynamic subtest engine: SUCCESS (0.676s)
[718.131857] Starting dynamic subtest: timelines
[722.058109] Dynamic subtest timelines: SUCCESS (3.934s)
[722.068317] Starting dynamic subtest: requests
[725.525758] Dynamic subtest requests: SUCCESS (3.466s)
[725.541634] Starting dynamic subtest: objects
[726.261317] Dynamic subtest objects: SUCCESS (0.735s)
[726.271634] Starting dynamic subtest: phys
[726.987903] Dynamic subtest phys: SUCCESS (0.724s)
[726.995697] Starting dynamic subtest: dmabuf
[727.750156] Dynamic subtest dmabuf: SUCCESS (0.761s)
[727.758413] Starting dynamic subtest: vma
[733.349038] Dynamic subtest vma: SUCCESS (5.597s)
[733.359235] Starting dynamic subtest: evict
[734.714072] Dynamic subtest evict: SUCCESS (1.364s)
[734.724723] Starting dynamic subtest: gtt
[738.020745] Dynamic subtest gtt: SUCCESS (3.304s)
[738.036744] Starting dynamic subtest: hugepages
[738.917452] Dynamic subtest hugepages: SUCCESS (0.895s)
[738.934090] Starting dynamic subtest: memory_region
[741.399056] Dynamic subtest memory_region: SUCCESS (2.479s)
[741.402033] Subtest mock: SUCCESS (39.303s)
[741.431609] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[741.432413] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[741.435888] [100/133] (293s left) kms_busy (basic)
[743.011210] Starting subtest: basic
[743.013578] Starting dynamic subtest: flip
[743.631935] Dynamic subtest flip: SUCCESS (0.620s)
[743.642664] Starting dynamic subtest: modeset
[747.044447] Dynamic subtest modeset: SUCCESS (3.410s)
[747.046824] Subtest basic: SUCCESS (4.033s)
[747.880947] [FACT kms_busy (basic)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[747.882226] [FACT kms_busy (basic)] new: kernel.kmod_is_loaded.i915: true
[747.886471] [101/133] (286s left) api_intel_allocator (reloc-allocator)
[747.960623] Starting subtest: reloc-allocator
[747.962668] Starting dynamic subtest: basic
[747.965128] Dynamic subtest basic: SUCCESS (0.004s)
[747.977450] Starting dynamic subtest: parallel-one
[747.979803] Dynamic subtest parallel-one: SUCCESS (0.007s)
[747.989343] Starting dynamic subtest: print
[747.991263] Dynamic subtest print: SUCCESS (0.000s)
[748.000040] Starting dynamic subtest: reuse
[748.002103] Dynamic subtest reuse: SUCCESS (0.000s)
[748.012297] Starting dynamic subtest: fork-reopen-allocator
[748.014180] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[748.016093] Subtest reloc-allocator: SUCCESS (0.027s)
[748.141410] [102/133] (286s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[748.253248] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[748.257598] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[748.351417] [103/133] (286s left) kms_concurrent (multi-plane-atomic-lowres)
[748.453233] Starting subtest: multi-plane-atomic-lowres
[748.455141] Starting dynamic subtest: pipe-A-eDP-1
[748.964848] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.510s)
[748.974594] Starting dynamic subtest: pipe-B-eDP-1
[750.178859] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.210s)
[750.191689] Starting dynamic subtest: pipe-C-eDP-1
[751.397481] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.218s)
[751.407639] Starting dynamic subtest: pipe-D-eDP-1
[752.622658] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[752.624896] Subtest multi-plane-atomic-lowres: SUCCESS (4.171s)
[753.442366] [104/133] (281s left) perf (create-destroy-userspace-config)
[753.595029] Starting subtest: create-destroy-userspace-config
[753.614566] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[753.659519] [105/133] (281s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[753.760422] Starting subtest: y-tiled-64bpp-rotate-180
[753.764489] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[753.866724] [106/133] (281s left) gem_ppgtt (shrink-vs-evict-any)
[753.923218] Starting subtest: shrink-vs-evict-any
[759.851775] Subtest shrink-vs-evict-any: SUCCESS (5.930s)
[759.936426] [107/133] (275s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[760.202110] Starting subtest: cursor-rapid-movement-256x85
[760.252152] Subtest cursor-rapid-movement-256x85: SKIP (0.045s)
[760.423940] [108/133] (274s left) kms_flip (modeset-vs-vblank-race-interruptible)
[760.516133] Starting subtest: modeset-vs-vblank-race-interruptible
[760.518516] Starting dynamic subtest: A-eDP1
[765.171682] Dynamic subtest A-eDP1: SUCCESS (4.655s)
[765.184041] Starting dynamic subtest: B-eDP1
[769.811776] Dynamic subtest B-eDP1: SUCCESS (4.637s)
[769.827512] Starting dynamic subtest: C-eDP1
[774.332596] Dynamic subtest C-eDP1: SUCCESS (4.518s)
[774.346572] Starting dynamic subtest: D-eDP1
[778.867462] Dynamic subtest D-eDP1: SUCCESS (4.532s)
[778.872781] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.357s)
[780.022629] [109/133] (255s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[780.117398] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[780.119770] Starting dynamic subtest: pipe-A-default-mode
[782.838397] Dynamic subtest pipe-A-default-mode: SUCCESS (2.720s)
[782.840244] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.721s)
[783.704203] [110/133] (251s left) kms_atomic (atomic-invalid-params)
[783.797940] Starting subtest: atomic-invalid-params
[783.800334] Starting dynamic subtest: pipe-A-eDP-1
[784.195462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.398s)
[784.197669] Subtest atomic-invalid-params: SUCCESS (0.399s)
[785.045759] [111/133] (250s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[785.136977] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[785.141287] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[785.229189] [112/133] (249s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[785.318270] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[786.109281] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.792s)
[786.276523] [113/133] (248s left) gem_tiled_pread_pwrite
[786.399549] [114/133] (248s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[786.493824] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[786.498266] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[786.591855] [115/133] (248s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[786.685840] Starting subtest: random-ccs-data-yf-tiled-ccs
[786.688108] Starting dynamic subtest: pipe-A-eDP-1
[786.712344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[786.722556] Starting dynamic subtest: pipe-B-eDP-1
[786.745917] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[786.755024] Starting dynamic subtest: pipe-C-eDP-1
[786.778840] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[786.787761] Starting dynamic subtest: pipe-D-eDP-1
[786.812176] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[786.816549] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[788.915131] [116/133] (246s left) kms_chamelium_edid (vga-edid-read)
[789.303545] Subtest vga-edid-read: SKIP (0.000s)
[790.133368] [117/133] (245s left) kms_getfb (getfb2-into-addfb2)
[790.236238] Starting subtest: getfb2-into-addfb2
[790.238574] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[790.343450] [118/133] (245s left) i915_pm_rpm (debugfs-forcewake-user)
[792.069954] Starting subtest: debugfs-forcewake-user
[803.466794] Subtest debugfs-forcewake-user: SUCCESS (11.400s)
[803.842739] [119/133] (231s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[803.929306] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[810.813067] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.885s)
[810.986550] [120/133] (224s left) gem_exec_flush (basic-wb-prw-default)
[811.042025] Starting subtest: basic-wb-prw-default
[816.514819] Subtest basic-wb-prw-default: SUCCESS (5.473s)
[816.715476] [121/133] (218s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[816.815707] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[816.819803] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[816.917909] [122/133] (218s left) fbdev (pan)
[816.949697] Starting subtest: pan
[816.979520] Subtest pan: SUCCESS (0.031s)
[817.047434] [123/133] (218s left) gem_readwrite (beyond-eob)
[817.107644] Subtest beyond-EOB: SKIP (0.000s)
[817.158762] [124/133] (218s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[817.258571] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[817.262641] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[817.366630] [125/133] (218s left) kms_big_fb (linear-32bpp-rotate-180)
[817.476344] Starting subtest: linear-32bpp-rotate-180
[818.911741] Subtest linear-32bpp-rotate-180: SUCCESS (1.436s)
[819.056053] [126/133] (216s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[819.157377] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[823.170241] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.017s)
[824.376619] [127/133] (211s left) kms_cursor_legacy (torture-move)
[824.496722] Starting subtest: torture-move
[824.498820] Starting dynamic subtest: pipe-A
[830.267831] Dynamic subtest pipe-A: SUCCESS (5.767s)
[830.285975] Starting dynamic subtest: pipe-B
[837.176093] Dynamic subtest pipe-B: SUCCESS (6.904s)
[837.191508] Starting dynamic subtest: pipe-C
[845.039219] Dynamic subtest pipe-C: SUCCESS (7.861s)
[845.051033] Starting dynamic subtest: pipe-D
[851.319772] Dynamic subtest pipe-D: SUCCESS (6.278s)
[851.329491] Starting dynamic subtest: all-pipes
[857.049950] Dynamic subtest all-pipes: SUCCESS (5.729s)
[857.052445] Subtest torture-move: SUCCESS (32.552s)
[857.212340] [128/133] (178s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[857.329137] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[857.333365] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[857.431613] [129/133] (178s left) gem_exec_reloc (basic-scanout)
[857.488575] Subtest basic-scanout: SKIP (0.000s)
[857.555274] [130/133] (178s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[859.075084] Starting subtest: modeset-lpsp-stress-no-wait
[869.280768] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.207s)
[869.367514] [131/133] (166s left) gem_ringfill (engines-basic)
[874.905806] Starting subtest: engines-basic
[874.908476] Starting dynamic subtest: rcs0
[874.978441] Dynamic subtest rcs0: SUCCESS (0.073s)
[874.992683] Starting dynamic subtest: bcs0
[875.022871] Dynamic subtest bcs0: SUCCESS (0.043s)
[875.040320] Starting dynamic subtest: vcs0
[875.066863] Dynamic subtest vcs0: SUCCESS (0.043s)
[875.076825] Starting dynamic subtest: vcs1
[875.113322] Dynamic subtest vcs1: SUCCESS (0.044s)
[875.124484] Starting dynamic subtest: vecs0
[875.156977] Dynamic subtest vecs0: SUCCESS (0.042s)
[875.167518] Starting dynamic subtest: ccs0
[875.202384] Dynamic subtest ccs0: SUCCESS (0.043s)
[875.204917] Subtest engines-basic: SUCCESS (0.298s)
[875.280230] [132/133] (160s left) kms_legacy_colorkey (invalid-plane)
[875.386739] Starting subtest: invalid-plane
[875.389066] Starting dynamic subtest: zero-id
[875.391212] Dynamic subtest zero-id: SUCCESS (0.000s)
[875.401849] Starting dynamic subtest: outrange-id
[875.403762] Dynamic subtest outrange-id: SUCCESS (0.000s)
[875.405612] Subtest invalid-plane: SUCCESS (0.001s)
[875.461718] [133/133] (160s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[875.560082] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[875.564218] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[875.650424] Closing watchdogs
results: parsing output: 0/ for test: kms_psr2_sf
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_cursor_crc
results: parsing output: 5/ for test: kms_vrr
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: kms_rotation_crc
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: gem_softpin
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: kms_sequence
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_exec_nop
results: parsing output: 24/ for test: kms_plane_alpha_blend
results: parsing output: 25/ for test: kms_plane_scaling
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: i915_hangman
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: sysfs_heartbeat_interval
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: perf_pmu
results: parsing output: 36/ for test: dmabuf_sync_file
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_vrr
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_color
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: gen3_render_tiledx_blits
results: parsing output: 43/ for test: kms_plane_cursor
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_feature_discovery
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: vgem_slow
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_exec_fence
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_joiner
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_render_copy
results: parsing output: 59/ for test: syncobj_wait
results: parsing output: 60/ for test: gem_eio
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: sw_sync
results: parsing output: 65/ for test: gem_request_retire
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: gem_basic
results: parsing output: 70/ for test: sriov_basic
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: prime_mmap_coherency
results: parsing output: 74/ for test: kms_force_connector_basic
results: parsing output: 75/ for test: kms_cursor_edge_walk
results: parsing output: 76/ for test: kms_prop_blob
results: parsing output: 77/ for test: gem_close
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_create
results: parsing output: 81/ for test: gem_tiled_wb
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_media_fill
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: vgem_basic
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_pm_rpm
results: parsing output: 98/ for test: i915_selftest
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: api_intel_allocator
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_concurrent
results: parsing output: 103/ for test: perf
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_ppgtt
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_tiled_pread_pwrite
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_chamelium_edid
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_flush
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: fbdev
results: parsing output: 122/ for test: gem_readwrite
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_pm_rpm
results: parsing output: 130/ for test: gem_ringfill
results: parsing output: 131/ for test: kms_legacy_colorkey
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.