[60.611198] Initializing watchdogs
[60.611250]   /dev/watchdog0
[60.625640] [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]
[60.630262] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.632569] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.634356] [001/133] (960s left) kms_addfb_basic (basic)
[60.697290] Starting subtest: basic
[60.698281] Subtest basic: SUCCESS (0.000s)
[60.877243] [002/133] (960s left) gem_userptr_blits (unsync-unmap-after-close)
[60.945542] Subtest unsync-unmap-after-close: SKIP (0.000s)
[61.082892] [003/133] (960s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[61.138460] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[61.208283] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[61.295679] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[61.297382] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[61.422233] [005/133] (959s left) kms_invalid_mode (bad-hsync-start)
[61.512062] Starting subtest: bad-hsync-start
[61.512993] Starting dynamic subtest: pipe-A-eDP-1
[61.799054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[61.807288] Starting dynamic subtest: pipe-B-eDP-1
[61.808246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.815208] Starting dynamic subtest: pipe-C-eDP-1
[61.816126] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[61.821605] Starting dynamic subtest: pipe-D-eDP-1
[61.822463] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.823609] Subtest bad-hsync-start: SUCCESS (0.290s)
[62.658874] [006/133] (958s left) gem_exec_schedule (implicit-read-write)
[62.720171] Starting subtest: implicit-read-write
[62.721186] Starting dynamic subtest: rcs0
[62.829116] Dynamic subtest rcs0: SUCCESS (0.108s)
[62.837402] Starting dynamic subtest: vcs0
[62.907841] Dynamic subtest vcs0: SUCCESS (0.078s)
[62.915478] Starting dynamic subtest: vcs1
[62.987785] Dynamic subtest vcs1: SUCCESS (0.079s)
[62.996000] Starting dynamic subtest: vecs0
[63.061283] Dynamic subtest vecs0: SUCCESS (0.073s)
[63.069918] Starting dynamic subtest: ccs0
[63.140671] Dynamic subtest ccs0: SUCCESS (0.079s)
[63.141978] Subtest implicit-read-write: SUCCESS (0.419s)
[64.009039] [007/133] (957s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[64.106523] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[64.107515] Starting dynamic subtest: pipe-A-eDP-1
[64.116843] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.124234] Starting dynamic subtest: pipe-B-eDP-1
[64.133890] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.140989] Starting dynamic subtest: pipe-C-eDP-1
[64.149869] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.155210] Starting dynamic subtest: pipe-D-eDP-1
[64.163639] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.165360] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[66.429947] [008/133] (954s left) syncobj_timeline (wait-for-submit-snapshot)
[66.478578] Starting subtest: wait-for-submit-snapshot
[66.561915] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[66.640420] [009/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[66.748848] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[74.127074] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.369s)
[74.289576] [010/133] (947s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[74.378929] Starting subtest: psr-dirtyfb-ioctl
[74.379822] Starting dynamic subtest: A-eDP-1
[78.281489] Dynamic subtest A-eDP-1: SUCCESS (3.899s)
[78.282616] Subtest psr-dirtyfb-ioctl: SUCCESS (3.900s)
[79.077434] [011/133] (942s left) gen7_exec_parse (basic-offset)
[79.140348] Subtest basic-offset: SKIP (0.000s)
[79.195711] [012/133] (942s left) kms_psr (pr-cursor-render)
[79.301826] Starting subtest: pr-cursor-render
[79.304209] Subtest pr-cursor-render: SKIP (0.000s)
[79.378684] [013/133] (942s left) kms_psr (psr-primary-render)
[79.471335] Starting subtest: psr-primary-render
[79.472284] Starting dynamic subtest: eDP-1
[81.177561] Dynamic subtest eDP-1: SUCCESS (1.705s)
[81.178456] Subtest psr-primary-render: SUCCESS (1.706s)
[82.047482] [014/133] (939s left) gem_vm_create (isolation)
[82.091559] Starting subtest: isolation
[82.099606] Subtest isolation: SUCCESS (0.008s)
[82.229658] [015/133] (939s left) i915_selftest (live)
[84.141607] Starting subtest: live
[84.142872] Starting dynamic subtest: sanitycheck
[88.542518] Dynamic subtest sanitycheck: SUCCESS (4.400s)
[88.550582] Starting dynamic subtest: uncore
[92.966382] Dynamic subtest uncore: SUCCESS (4.422s)
[92.974265] Starting dynamic subtest: workarounds
[109.846760] Dynamic subtest workarounds: FAIL (16.688s)
[109.852752] Starting dynamic subtest: gt_engines
[114.368214] Dynamic subtest gt_engines: SUCCESS (4.708s)
[114.376103] Starting dynamic subtest: gt_timelines
[130.265310] Dynamic subtest gt_timelines: SUCCESS (15.895s)
[130.273686] Starting dynamic subtest: gt_contexts
[134.700321] Dynamic subtest gt_contexts: SUCCESS (4.434s)
[134.707893] Starting dynamic subtest: gt_lrc
[139.193953] Dynamic subtest gt_lrc: SUCCESS (4.492s)
[139.201680] Starting dynamic subtest: gt_mocs
[142.321949] Dynamic subtest gt_mocs: SUCCESS (3.126s)
[142.329795] Starting dynamic subtest: gt_pm
[149.263556] Dynamic subtest gt_pm: SUCCESS (6.939s)
[149.271126] Starting dynamic subtest: gt_heartbeat
[153.689964] Dynamic subtest gt_heartbeat: SUCCESS (4.425s)
[153.697296] Starting dynamic subtest: gt_tlb
[163.144990] Dynamic subtest gt_tlb: SUCCESS (9.453s)
[163.152848] Starting dynamic subtest: requests
[174.896082] Dynamic subtest requests: SUCCESS (11.757s)
[174.903893] Starting dynamic subtest: migrate
[181.085836] Dynamic subtest migrate: SUCCESS (6.179s)
[181.093921] Starting dynamic subtest: active
[183.892504] Dynamic subtest active: SUCCESS (2.805s)
[183.900105] Starting dynamic subtest: objects
[187.218945] Dynamic subtest objects: SUCCESS (3.326s)
[187.226892] Starting dynamic subtest: mman
[192.205847] Dynamic subtest mman: SUCCESS (4.985s)
[192.213171] Starting dynamic subtest: dmabuf
[195.111787] Dynamic subtest dmabuf: SUCCESS (2.904s)
[195.117574] Starting dynamic subtest: vma
[199.513801] Dynamic subtest vma: SUCCESS (4.399s)
[199.521624] Starting dynamic subtest: coherency
[204.642205] Dynamic subtest coherency: SUCCESS (5.126s)
[204.650063] Starting dynamic subtest: gtt
[216.595803] Dynamic subtest gtt: SUCCESS (11.951s)
[216.602597] Starting dynamic subtest: gem
[224.730844] Dynamic subtest gem: SUCCESS (8.133s)
[224.737906] Starting dynamic subtest: evict
[230.368333] Dynamic subtest evict: SUCCESS (5.636s)
[230.376405] Starting dynamic subtest: hugepages
[241.568214] Dynamic subtest hugepages: SUCCESS (11.199s)
[241.575538] Starting dynamic subtest: gem_contexts
[269.881217] Dynamic subtest gem_contexts: SUCCESS (28.309s)
[269.889213] Starting dynamic subtest: client
[274.318428] Dynamic subtest client: SUCCESS (4.435s)
[274.326699] Starting dynamic subtest: gem_migrate
[277.209368] Dynamic subtest gem_migrate: SUCCESS (2.889s)
[277.217327] Starting dynamic subtest: reset
[280.103320] Dynamic subtest reset: SUCCESS (2.892s)
[280.111127] Starting dynamic subtest: memory_region
[284.582870] Dynamic subtest memory_region: SUCCESS (4.478s)
[284.591250] Starting dynamic subtest: hangcheck
[300.034518] Dynamic subtest hangcheck: SUCCESS (15.449s)
[300.042210] Starting dynamic subtest: execlists
[304.458472] Dynamic subtest execlists: SUCCESS (4.422s)
[304.466106] Starting dynamic subtest: ring_submission
[308.879763] Dynamic subtest ring_submission: SUCCESS (4.419s)
[308.887588] Starting dynamic subtest: perf
[313.325194] Dynamic subtest perf: SUCCESS (4.444s)
[313.332897] Starting dynamic subtest: slpc
[327.583706] Dynamic subtest slpc: SUCCESS (14.255s)
[327.591580] Starting dynamic subtest: guc
[331.490862] Dynamic subtest guc: SUCCESS (3.913s)
[331.498278] Starting dynamic subtest: guc_multi_lrc
[336.073316] Dynamic subtest guc_multi_lrc: SUCCESS (4.572s)
[336.081537] Starting dynamic subtest: guc_hang
[341.078230] Dynamic subtest guc_hang: SUCCESS (5.002s)
[341.086295] Starting dynamic subtest: late_gt_pm
[345.519048] Dynamic subtest late_gt_pm: SUCCESS (4.438s)
[345.520108] Subtest live: FAIL (261.357s)
[345.538397] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[345.540107] [016/133] (676s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[347.117955] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[351.457590] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.339s)
[352.649369] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[352.651428] [017/133] (668s left) gem_userptr_blits (readonly-unsync)
[352.724175] Subtest readonly-unsync: SKIP (0.000s)
[352.861837] [018/133] (668s left) drm_buddy (drm_buddy)
[352.899521] Starting subtest: drm_buddy
[352.901382] Subtest drm_buddy: SKIP (0.001s)
[352.959822] [019/133] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[353.057253] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[353.059116] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[353.180371] [020/133] (668s left) fbdev (read)
[353.214500] Starting subtest: read
[353.749392] Subtest read: SUCCESS (0.535s)
[353.815665] [021/133] (667s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[353.926242] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[353.928591] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[354.045877] [022/133] (667s left) kms_vblank (ts-continuation-suspend)
[354.133435] Starting subtest: ts-continuation-suspend
[354.134284] Starting dynamic subtest: pipe-A-eDP-1
[370.894235] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.016s)
[370.902931] Starting dynamic subtest: pipe-D-eDP-1
[388.892108] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.586s)
[388.892863] Subtest ts-continuation-suspend: SUCCESS (4.606s)
[396.720354] [023/133] (632s left) kms_cursor_crc (cursor-random-64x64)
[396.907917] Starting subtest: cursor-random-64x64
[396.913121] Starting dynamic subtest: pipe-A-eDP-1
[400.333086] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.337s)
[400.361214] Starting dynamic subtest: pipe-D-eDP-1
[404.453406] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.037s)
[404.454383] Subtest cursor-random-64x64: SUCCESS (7.401s)
[405.328173] [024/133] (623s left) gem_ctx_engines (independent)
[405.382308] Starting subtest: independent
[405.383360] Starting dynamic subtest: rcs0
[405.536926] Dynamic subtest rcs0: SUCCESS (0.143s)
[405.545982] Starting dynamic subtest: bcs0
[405.642722] Dynamic subtest bcs0: SUCCESS (0.113s)
[405.650621] Starting dynamic subtest: vcs0
[405.760134] Dynamic subtest vcs0: SUCCESS (0.115s)
[405.770677] Starting dynamic subtest: vcs1
[405.889706] Dynamic subtest vcs1: SUCCESS (0.116s)
[405.899594] Starting dynamic subtest: vecs0
[406.002306] Dynamic subtest vecs0: SUCCESS (0.122s)
[406.012669] Starting dynamic subtest: ccs0
[406.145455] Dynamic subtest ccs0: SUCCESS (0.132s)
[406.155682] Starting dynamic subtest: all-engines
[406.535801] Dynamic subtest all-engines: SUCCESS (0.386s)
[406.536817] Subtest independent: SUCCESS (1.135s)
[407.259123] [025/133] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[407.349348] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[414.159992] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.775s)
[414.345302] [026/133] (614s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[414.445355] Starting subtest: fbc-modesetfrombusy
[418.275334] Subtest fbc-modesetfrombusy: SUCCESS (3.820s)
[419.462695] [027/133] (609s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[419.522746] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[419.626720] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s)
[419.729464] [028/133] (609s left) kms_cursor_edge_walk (256x256-top-edge)
[419.830527] Starting subtest: 256x256-top-edge
[419.831492] Starting dynamic subtest: pipe-A-eDP-1
[423.299234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[423.307747] Starting dynamic subtest: pipe-D-eDP-1
[426.424650] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[426.425714] Subtest 256x256-top-edge: SUCCESS (6.587s)
[427.253338] [029/133] (601s left) kms_vrr (seamless-rr-switch-virtual)
[427.362700] Starting subtest: seamless-rr-switch-virtual
[427.365546] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[427.437939] [030/133] (601s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[427.496196] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[427.498006] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[427.681933] [031/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[427.767942] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[427.769589] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[427.874604] [032/133] (601s left) kms_big_fb (linear-32bpp-rotate-270)
[427.957620] Starting subtest: linear-32bpp-rotate-270
[427.977194] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[428.116209] [033/133] (601s left) kms_getfb (getfb2-handle-protection)
[428.211586] Starting subtest: getfb2-handle-protection
[428.241312] Subtest getfb2-handle-protection: SUCCESS (0.031s)
[428.399945] [034/133] (600s left) kms_pm_rpm (system-suspend-modeset)
[430.217705] Starting subtest: system-suspend-modeset
[450.143683] Subtest system-suspend-modeset: SUCCESS (5.017s)
[455.559355] [035/133] (578s left) syncobj_timeline (invalid-signal-illegal-handle)
[455.630211] Starting subtest: invalid-signal-illegal-handle
[455.631171] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[455.744192] [036/133] (578s left) kms_chamelium_hpd (common-hpd-after-suspend)
[456.128761] Subtest common-hpd-after-suspend: SKIP (0.000s)
[456.952967] [037/133] (577s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[457.054891] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[457.056762] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[458.257636] [038/133] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[458.351948] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[458.353833] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[458.458050] [039/133] (575s left) gem_exec_balancer (smoke)
[458.519620] Starting subtest: smoke
[481.333521] Subtest smoke: SUCCESS (22.606s)
[482.370419] [040/133] (552s left) kms_setmode (basic)
[482.425086] Starting subtest: basic
[482.749158] Starting dynamic subtest: pipe-A-eDP-1
[486.247803] Dynamic subtest pipe-A-eDP-1: FAIL (3.432s)
[486.533948] Starting dynamic subtest: pipe-B-eDP-1
[488.583799] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.047s)
[488.898292] Subtest basic: FAIL (6.468s)
[489.726587] [041/133] (544s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[489.825866] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[489.827571] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.941143] [042/133] (544s left) kms_color (deep-color)
[490.034129] Starting subtest: deep-color
[491.088806] Starting dynamic subtest: pipe-A-eDP-1-gamma
[491.828632] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.740s)
[491.836236] Starting dynamic subtest: pipe-A-eDP-1-degamma
[493.292585] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.463s)
[493.300046] Starting dynamic subtest: pipe-A-eDP-1-ctm
[494.721269] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.428s)
[495.493569] Starting dynamic subtest: pipe-B-eDP-1-gamma
[496.191972] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.705s)
[496.199811] Starting dynamic subtest: pipe-B-eDP-1-degamma
[497.634001] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.442s)
[497.641510] Starting dynamic subtest: pipe-B-eDP-1-ctm
[499.038087] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.402s)
[499.813087] Starting dynamic subtest: pipe-C-eDP-1-gamma
[500.497916] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s)
[500.507381] Starting dynamic subtest: pipe-C-eDP-1-degamma
[501.887489] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.388s)
[501.895194] Starting dynamic subtest: pipe-C-eDP-1-ctm
[503.279452] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.391s)
[504.095830] Starting dynamic subtest: pipe-D-eDP-1-gamma
[504.810578] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.722s)
[504.820393] Starting dynamic subtest: pipe-D-eDP-1-degamma
[506.256687] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.443s)
[506.264503] Starting dynamic subtest: pipe-D-eDP-1-ctm
[507.683088] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.426s)
[507.684288] Subtest deep-color: SUCCESS (17.648s)
[508.538916] [043/133] (525s left) gem_lmem_swapping (parallel-random-verify)
[508.578894] Subtest parallel-random-verify: SKIP (0.000s)
[508.614765] [044/133] (525s left) kms_flip (dpms-vs-vblank-race)
[508.698918] Starting subtest: dpms-vs-vblank-race
[508.701385] Starting dynamic subtest: A-eDP1
[512.521136] Dynamic subtest A-eDP1: SUCCESS (3.818s)
[512.529855] Starting dynamic subtest: B-eDP1
[517.146058] Dynamic subtest B-eDP1: SUCCESS (4.622s)
[517.155605] Starting dynamic subtest: C-eDP1
[521.776268] Dynamic subtest C-eDP1: SUCCESS (4.628s)
[521.783595] Starting dynamic subtest: D-eDP1
[526.399918] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[526.402028] Subtest dpms-vs-vblank-race: SUCCESS (17.700s)
[527.287514] [045/133] (507s left) kms_chamelium_color (degamma)
[527.388026] Subtest degamma: SKIP (0.000s)
[527.432977] [046/133] (507s left) api_intel_bb (add-remove-objects)
[527.480795] Starting subtest: add-remove-objects
[527.486975] Subtest add-remove-objects: SUCCESS (0.007s)
[527.620067] [047/133] (507s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[527.739191] Starting subtest: cursor-vs-flip-atomic
[557.087758] Subtest cursor-vs-flip-atomic: SUCCESS (29.341s)
[557.921821] [048/133] (476s left) gem_userptr_blits (readonly-pwrite-unsync)
[557.980089] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[558.130515] [049/133] (476s left) gem_exec_schedule (wide)
[558.318433] Starting subtest: wide
[558.319774] Starting dynamic subtest: rcs0
[568.641069] Dynamic subtest rcs0: SUCCESS (10.280s)
[568.649823] Starting dynamic subtest: vcs0
[578.726335] Dynamic subtest vcs0: SUCCESS (10.118s)
[578.736987] Starting dynamic subtest: vcs1
[590.143094] Dynamic subtest vcs1: SUCCESS (11.411s)
[590.153329] Starting dynamic subtest: vecs0
[601.247758] Dynamic subtest vecs0: SUCCESS (11.099s)
[601.255763] Starting dynamic subtest: ccs0
[614.477945] Dynamic subtest ccs0: SUCCESS (13.188s)
[614.479254] Subtest wide: SUCCESS (56.101s)
[616.468843] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[616.471334] [050/133] (418s left) kms_force_connector_basic (force-load-detect)
[616.558779] Starting subtest: force-load-detect
[616.560497] Subtest force-load-detect: SKIP (0.000s)
[616.684338] [051/133] (418s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[616.732791] Starting subtest: multi-wait-all-for-submit-submitted
[616.840418] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[616.921457] [052/133] (417s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[617.039771] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[634.208243] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.161s)
[635.105968] [053/133] (399s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[635.207412] Starting subtest: yf-tiled-8bpp-rotate-270
[635.209145] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[635.318814] [054/133] (399s left) core_auth (getclient-simple)
[635.348305] Starting subtest: getclient-simple
[635.373354] Subtest getclient-simple: SUCCESS (0.023s)
[635.498997] [055/133] (399s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[635.592145] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[635.594219] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[635.682517] [056/133] (399s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[635.776168] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[635.777772] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[635.890887] [057/133] (399s left) gem_exec_reloc (basic-wc)
[635.942620] Subtest basic-wc: SKIP (0.000s)
[636.020352] [058/133] (398s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[636.112924] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[636.114709] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[636.227798] [059/133] (398s left) syncobj_basic (illegal-fd-to-handle)
[636.283687] Starting subtest: illegal-fd-to-handle
[636.284637] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[636.394903] [060/133] (398s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[636.479454] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[636.481303] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[636.558476] [061/133] (398s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[636.656910] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[636.658815] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[636.782483] [062/133] (398s left) kms_flip (wf_vblank-ts-check)
[636.862794] Starting subtest: wf_vblank-ts-check
[636.864888] Starting dynamic subtest: A-eDP1
[645.854736] Dynamic subtest A-eDP1: SUCCESS (8.963s)
[645.864357] Starting dynamic subtest: B-eDP1
[654.759438] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[654.768721] Starting dynamic subtest: C-eDP1
[663.721560] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[663.732224] Starting dynamic subtest: D-eDP1
[672.641518] Dynamic subtest D-eDP1: SUCCESS (8.918s)
[672.642573] Subtest wf_vblank-ts-check: SUCCESS (35.754s)
[673.846983] [063/133] (361s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[673.941875] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[673.942736] Starting dynamic subtest: pipe-A-eDP-1
[673.950754] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[673.963726] Starting dynamic subtest: pipe-B-eDP-1
[673.972031] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[673.984224] Starting dynamic subtest: pipe-C-eDP-1
[673.992094] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[674.003890] Starting dynamic subtest: pipe-D-eDP-1
[674.013622] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[674.015575] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[676.118021] [064/133] (359s left) kms_psr (fbc-pr-cursor-blt)
[676.229793] Starting subtest: fbc-pr-cursor-blt
[676.231506] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[676.330558] [065/133] (358s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[676.421809] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[676.422690] Starting dynamic subtest: pipe-A
[676.439991] Dynamic subtest pipe-A: SKIP (0.016s)
[676.448110] Starting dynamic subtest: pipe-B
[676.471037] Dynamic subtest pipe-B: SKIP (0.030s)
[676.478880] Starting dynamic subtest: pipe-C
[676.500594] Dynamic subtest pipe-C: SKIP (0.030s)
[676.508104] Starting dynamic subtest: pipe-D
[676.530622] Dynamic subtest pipe-D: SKIP (0.029s)
[676.532275] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.108s)
[676.644910] [066/133] (358s left) sw_sync (alloc_timeline)
[676.671768] Starting subtest: alloc_timeline
[676.672601] Subtest alloc_timeline: SUCCESS (0.000s)
[676.731786] [067/133] (358s left) kms_selftest (drm_format_helper)
[676.761900] Starting subtest: drm_format_helper
[676.801030] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[676.914970] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.114s)
[676.924644] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[677.062404] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.138s)
[677.071349] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[677.206427] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.143s)
[677.215627] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[677.360850] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.154s)
[677.369993] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[677.506940] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.151s)
[677.515347] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[677.656345] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.143s)
[677.665501] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[677.797934] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.139s)
[677.807294] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[677.940130] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.142s)
[677.949792] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[678.088095] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.147s)
[678.097469] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[678.208381] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.126s)
[678.216271] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[678.360784] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.146s)
[678.368868] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[678.450860] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.095s)
[678.459400] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[678.546267] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.093s)
[678.554367] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[678.698206] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.145s)
[678.707386] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[678.843041] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.142s)
[678.850986] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[678.923491] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.086s)
[678.936345] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[679.042587] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.120s)
[679.044517] Subtest drm_format_helper: SUCCESS (2.282s)
[679.244046] [068/133] (356s left) gem_userptr_blits (sync-unmap-cycles)
[679.315132] Starting subtest: sync-unmap-cycles
[684.693112] Subtest sync-unmap-cycles: SUCCESS (5.380s)
[684.872178] [069/133] (350s left) perf_pmu (rc6)
[684.907626] Starting subtest: rc6
[684.908434] Starting dynamic subtest: gt0
[691.340085] Dynamic subtest gt0: SUCCESS (6.388s)
[691.348890] Starting dynamic subtest: runtime-pm-gt0
[699.031371] Dynamic subtest runtime-pm-gt0: SUCCESS (7.724s)
[699.042305] Starting dynamic subtest: runtime-pm-long-gt0
[711.469462] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.435s)
[711.481067] Starting dynamic subtest: other-idle-gt0
[717.812581] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[717.823766] Starting dynamic subtest: gt1
[724.154474] Dynamic subtest gt1: SUCCESS (6.339s)
[724.165563] Starting dynamic subtest: runtime-pm-gt1
[731.672882] Dynamic subtest runtime-pm-gt1: SUCCESS (7.515s)
[731.681990] Starting dynamic subtest: runtime-pm-long-gt1
[744.094564] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.418s)
[744.105862] Starting dynamic subtest: other-idle-gt1
[750.438020] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[750.439373] Subtest rc6: SUCCESS (65.518s)
[751.071059] [070/133] (284s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[751.169640] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[751.181688] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[751.276500] [071/133] (284s left) gem_exec_reloc (basic-cpu)
[751.331986] Subtest basic-cpu: SKIP (0.000s)
[751.413830] [072/133] (284s left) kms_psr (psr2-primary-mmap-cpu)
[751.509001] Starting subtest: psr2-primary-mmap-cpu
[751.510021] Starting dynamic subtest: eDP-1
[753.177497] Dynamic subtest eDP-1: SUCCESS (1.668s)
[753.178380] Subtest psr2-primary-mmap-cpu: SUCCESS (1.669s)
[754.041144] [073/133] (281s left) sriov_basic (enable-vfs-autoprobe-on)
[754.105088] Starting subtest: enable-vfs-autoprobe-on
[754.106073] Starting dynamic subtest: numvfs-1
[754.133801] Dynamic subtest numvfs-1: FAIL (0.006s)
[754.142720] Starting dynamic subtest: numvfs-2
[754.169838] Dynamic subtest numvfs-2: FAIL (0.004s)
[754.177467] Starting dynamic subtest: numvfs-3
[754.203903] Dynamic subtest numvfs-3: FAIL (0.003s)
[754.212038] Starting dynamic subtest: numvfs-4
[754.238377] Dynamic subtest numvfs-4: FAIL (0.004s)
[754.246268] Starting dynamic subtest: numvfs-5
[754.273487] Dynamic subtest numvfs-5: FAIL (0.003s)
[754.282345] Starting dynamic subtest: numvfs-6
[754.308022] Dynamic subtest numvfs-6: FAIL (0.004s)
[754.315731] Starting dynamic subtest: numvfs-7
[754.341284] Dynamic subtest numvfs-7: FAIL (0.003s)
[754.349016] Starting dynamic subtest: numvfs-random
[754.373993] Dynamic subtest numvfs-random: FAIL (0.003s)
[754.381906] Starting dynamic subtest: numvfs-all
[754.407153] Dynamic subtest numvfs-all: FAIL (0.004s)
[754.407942] Subtest enable-vfs-autoprobe-on: FAIL (0.041s)
[754.436493] [074/133] (281s left) i915_pm_freq_api (freq-reset)
[754.505731] Starting subtest: freq-reset
[754.506652] Starting dynamic subtest: gt0
[754.700784] Dynamic subtest gt0: SUCCESS (0.194s)
[754.709415] Starting dynamic subtest: gt1
[754.882357] Dynamic subtest gt1: SUCCESS (0.170s)
[754.883496] Subtest freq-reset: SUCCESS (0.366s)
[754.917953] [075/133] (280s left) gem_exec_nop (basic-parallel)
[754.983307] Starting subtest: basic-parallel
[770.919226] Subtest basic-parallel: SUCCESS (15.924s)
[771.136939] [076/133] (264s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[771.234816] Starting subtest: primary-y-tiled-reflect-x-180
[771.294394] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[771.370926] [077/133] (264s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[771.463919] Starting subtest: fbc-psr2-cursor-plane-update-sf
[771.464721] Starting dynamic subtest: pipe-A-eDP-1
[771.542545] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[771.552588] Starting dynamic subtest: pipe-B-eDP-1
[772.635211] Dynamic subtest pipe-B-eDP-1: SKIP (1.091s)
[772.636989] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.171s)
[773.809265] [078/133] (261s left) syncobj_timeline (reset-multiple-signaled)
[773.874077] Starting subtest: reset-multiple-signaled
[773.875222] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[773.958090] [079/133] (261s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[774.056894] Starting subtest: 4-tiled-8bpp-rotate-270
[774.077899] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[774.191478] [080/133] (261s left) gem_spin_batch (resubmit-new)
[774.250183] Starting subtest: resubmit-new
[774.251127] Starting dynamic subtest: rcs0
[774.258817] Dynamic subtest rcs0: SUCCESS (0.010s)
[774.268944] Starting dynamic subtest: bcs0
[774.269890] Dynamic subtest bcs0: SUCCESS (0.005s)
[774.279909] Starting dynamic subtest: vcs0
[774.280715] Dynamic subtest vcs0: SUCCESS (0.006s)
[774.290476] Starting dynamic subtest: vcs1
[774.291549] Dynamic subtest vcs1: SUCCESS (0.006s)
[774.299928] Starting dynamic subtest: vecs0
[774.300723] Dynamic subtest vecs0: SUCCESS (0.004s)
[774.309208] Starting dynamic subtest: ccs0
[774.310020] Dynamic subtest ccs0: SUCCESS (0.005s)
[774.310860] Subtest resubmit-new: SUCCESS (0.042s)
[775.985318] [081/133] (259s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[776.102195] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[777.136615] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.035s)
[777.252816] [082/133] (258s left) kms_pm_dc (dc3co-vpb-simulation)
[778.352751] Starting subtest: dc3co-vpb-simulation
[786.994307] Subtest dc3co-vpb-simulation: SKIP (8.593s)
[787.043685] [083/133] (248s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[787.145771] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[787.147464] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[787.227894] [084/133] (248s left) perf_pmu (init-busy)
[787.259071] Starting subtest: init-busy
[787.260079] Starting dynamic subtest: rcs0
[787.261005] Dynamic subtest rcs0: SUCCESS (0.001s)
[787.270816] Starting dynamic subtest: bcs0
[787.271626] Dynamic subtest bcs0: SUCCESS (0.000s)
[787.280058] Starting dynamic subtest: vcs0
[787.280987] Dynamic subtest vcs0: SUCCESS (0.001s)
[787.289964] Starting dynamic subtest: vcs1
[787.290824] Dynamic subtest vcs1: SUCCESS (0.001s)
[787.298861] Starting dynamic subtest: vecs0
[787.299758] Dynamic subtest vecs0: SUCCESS (0.001s)
[787.307960] Starting dynamic subtest: ccs0
[787.308786] Dynamic subtest ccs0: SUCCESS (0.000s)
[787.309599] Subtest init-busy: SUCCESS (0.008s)
[787.348359] [085/133] (248s left) gem_sync (basic-all)
[787.421768] Starting subtest: basic-all
[790.948403] Subtest basic-all: SUCCESS (3.517s)
[791.097932] [086/133] (244s left) syncobj_wait (single-wait-for-submit-submitted)
[791.155789] Starting subtest: single-wait-for-submit-submitted
[791.264544] Subtest single-wait-for-submit-submitted: SUCCESS (0.106s)
[791.314495] [087/133] (244s left) gem_exec_reloc (basic-active)
[791.379366] Subtest basic-active: SKIP (0.000s)
[791.448017] [088/133] (244s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[791.547957] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[791.548864] Starting dynamic subtest: pipe-A
[791.566542] Dynamic subtest pipe-A: SKIP (0.018s)
[791.581051] Starting dynamic subtest: pipe-B
[791.597886] Dynamic subtest pipe-B: SKIP (0.031s)
[791.606619] Starting dynamic subtest: pipe-C
[791.629456] Dynamic subtest pipe-C: SKIP (0.031s)
[791.637897] Starting dynamic subtest: pipe-D
[791.661101] Dynamic subtest pipe-D: SKIP (0.031s)
[791.662760] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s)
[791.735881] [089/133] (244s left) gem_ctx_isolation (nonpriv)
[791.805003] Starting subtest: nonpriv
[791.806003] Starting dynamic subtest: rcs0
[792.048696] Dynamic subtest rcs0: SUCCESS (0.243s)
[792.059593] Starting dynamic subtest: bcs0
[792.336934] Dynamic subtest bcs0: SUCCESS (0.287s)
[792.348415] Starting dynamic subtest: vcs0
[792.624502] Dynamic subtest vcs0: SUCCESS (0.287s)
[792.635901] Starting dynamic subtest: vcs1
[794.219656] Dynamic subtest vcs1: SUCCESS (1.594s)
[794.230922] Starting dynamic subtest: vecs0
[796.272943] Dynamic subtest vecs0: SUCCESS (2.052s)
[796.284051] Starting dynamic subtest: ccs0
[798.283666] Dynamic subtest ccs0: SUCCESS (2.009s)
[798.284721] Subtest nonpriv: SUCCESS (6.477s)
[798.530618] [090/133] (237s left) kms_async_flips (crc)
[798.626582] Starting subtest: crc
[799.011139] Starting dynamic subtest: pipe-A-eDP-1
[801.955517] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.944s)
[802.333507] Starting dynamic subtest: pipe-B-eDP-1
[805.189462] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s)
[805.565067] Starting dynamic subtest: pipe-C-eDP-1
[808.410706] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.853s)
[808.770741] Starting dynamic subtest: pipe-D-eDP-1
[811.651094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.887s)
[811.653301] Subtest crc: SUCCESS (13.023s)
[812.779768] [091/133] (223s left) i915_pm_rps (engine-order)
[812.831812] Starting subtest: engine-order
[818.839812] Subtest engine-order: SUCCESS (5.998s)
[818.956034] [092/133] (217s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[819.064419] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[823.704317] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.639s)
[824.796857] [093/133] (211s left) gem_exec_fence (parallel)
[824.968553] Starting subtest: parallel
[824.969696] Starting dynamic subtest: rcs0
[827.117315] Dynamic subtest rcs0: SUCCESS (2.148s)
[827.134390] Starting dynamic subtest: bcs0
[829.266400] Dynamic subtest bcs0: SUCCESS (2.148s)
[829.276035] Starting dynamic subtest: vcs0
[831.421793] Dynamic subtest vcs0: SUCCESS (2.154s)
[831.432274] Starting dynamic subtest: vcs1
[833.571929] Dynamic subtest vcs1: SUCCESS (2.149s)
[833.582178] Starting dynamic subtest: vecs0
[835.723797] Dynamic subtest vecs0: SUCCESS (2.151s)
[835.732189] Starting dynamic subtest: ccs0
[837.879230] Dynamic subtest ccs0: SUCCESS (2.154s)
[837.880171] Subtest parallel: SUCCESS (12.908s)
[839.016437] [094/133] (197s left) syncobj_timeline (wait-all-for-submit-complex)
[839.080748] Starting subtest: wait-all-for-submit-complex
[839.305027] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[839.344356] [095/133] (196s left) kms_lease (lease-invalid-connector)
[839.450861] Starting subtest: lease-invalid-connector
[839.451822] Starting dynamic subtest: pipe-A-eDP-1
[839.452713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[839.466176] Starting dynamic subtest: pipe-B-eDP-1
[839.467145] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[839.478022] Starting dynamic subtest: pipe-C-eDP-1
[839.478906] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[839.487369] Starting dynamic subtest: pipe-D-eDP-1
[839.488360] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[839.489324] Subtest lease-invalid-connector: SUCCESS (0.005s)
[839.519917] [096/133] (196s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[839.582751] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[839.584718] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[839.737732] [097/133] (196s left) kms_psr (fbc-psr2-sprite-plane-move)
[839.817879] Starting subtest: fbc-psr2-sprite-plane-move
[839.818825] Starting dynamic subtest: eDP-1
[839.820602] Dynamic subtest eDP-1: SKIP (0.000s)
[839.822254] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[839.861979] [098/133] (196s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[839.961251] Starting subtest: y-tiled-64bpp-rotate-270
[839.963092] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[840.044613] [099/133] (196s left) gem_exec_schedule (semaphore-noskip)
[840.110001] Starting subtest: semaphore-noskip
[840.535279] Subtest semaphore-noskip: SUCCESS (0.414s)
[840.858725] [100/133] (195s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[840.953564] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[840.955174] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[841.041270] [101/133] (195s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[841.154125] Starting subtest: flip-vs-cursor-busy-crc-atomic
[841.946547] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.792s)
[842.722363] [102/133] (193s left) gem_exec_flush (basic-uc-pro-default)
[842.798430] Starting subtest: basic-uc-pro-default
[848.261765] Subtest basic-uc-pro-default: SUCCESS (5.463s)
[848.420540] [103/133] (188s left) gem_exec_balancer (bonded-dual)
[848.480724] Starting subtest: bonded-dual
[848.482513] Subtest bonded-dual: SKIP (0.000s)
[848.761403] [104/133] (187s left) kms_psr (fbc-pr-sprite-blt)
[848.864563] Starting subtest: fbc-pr-sprite-blt
[848.866381] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[848.909078] [105/133] (187s left) gem_gpgpu_fill (offset-16x16)
[848.968198] Starting subtest: offset-16x16
[848.976401] Subtest offset-16x16: SUCCESS (0.008s)
[849.082953] [106/133] (187s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[849.175198] Starting subtest: plane-primary-overlay-mutable-zpos
[852.591591] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.415s)
[853.756092] [107/133] (182s left) gem_pread (snoop)
[853.821674] Subtest snoop: SKIP (0.000s)
[853.895924] [108/133] (182s left) gem_mmap_gtt (hang-busy)
[853.946412] Subtest hang-busy: SKIP (0.000s)
[854.016463] [109/133] (182s left) gem_mmap_wc (fault-concurrent)
[854.069379] Subtest fault-concurrent: SKIP (0.000s)
[854.156787] [110/133] (182s left) kms_content_protection (suspend-resume)
[854.295155] Starting subtest: suspend-resume
[854.297327] Subtest suspend-resume: SKIP (0.000s)
[854.407162] [111/133] (182s left) gem_exec_alignment (forked)
[854.462830] Starting subtest: forked
[895.179396] Subtest forked: SUCCESS (40.659s)
[895.665351] [112/133] (141s left) syncobj_wait (multi-wait-all-submitted-signaled)
[895.759762] Starting subtest: multi-wait-all-submitted-signaled
[895.862825] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.102s)
[895.913055] [113/133] (141s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[895.975469] Starting subtest: invalid-bsd2-flag-on-blt
[895.976411] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[896.068508] [114/133] (140s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[896.172553] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[896.174760] Starting dynamic subtest: pipe-A-default-mode
[897.406808] Dynamic subtest pipe-A-default-mode: SKIP (1.232s)
[897.408283] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.235s)
[897.549579] [115/133] (139s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[897.609695] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[897.711519] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.102s)
[897.759631] [116/133] (139s left) gem_madvise (dontneed-after-mmap)
[897.789783] Starting subtest: dontneed-after-mmap
[897.815454] Subtest dontneed-after-mmap: SUCCESS (0.026s)
[897.897229] [117/133] (139s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[897.994906] Starting subtest: dsc-fractional-bpp-with-bpc
[898.005959] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[898.039768] [118/133] (139s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[898.132231] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[902.195088] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.065s)
[903.289785] [119/133] (133s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[903.387895] Starting subtest: bad-rotation-90-yf-tiled-ccs
[903.388806] Starting dynamic subtest: pipe-A-eDP-1
[903.397325] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[903.406518] Starting dynamic subtest: pipe-B-eDP-1
[903.414979] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[903.424088] Starting dynamic subtest: pipe-C-eDP-1
[903.432071] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[903.441124] Starting dynamic subtest: pipe-D-eDP-1
[903.449735] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[903.451457] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.004s)
[905.665359] [120/133] (131s left) gem_mmap_offset (pf-nonblock)
[905.722915] Starting subtest: pf-nonblock
[905.728778] Subtest pf-nonblock: SUCCESS (0.006s)
[905.847349] [121/133] (131s left) kms_cursor_crc (cursor-offscreen-512x170)
[906.129945] Starting subtest: cursor-offscreen-512x170
[906.133034] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[906.231141] [122/133] (130s left) sw_sync (sync_multi_timeline_wait)
[906.261501] Starting subtest: sync_multi_timeline_wait
[906.262462] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[906.294036] [123/133] (130s left) gem_ctx_persistence (processes)
[906.362642] Starting subtest: processes
[907.957009] Subtest processes: SUCCESS (1.596s)
[908.008248] [124/133] (129s left) kms_plane_alpha_blend (coverage-7efc)
[908.103171] Starting subtest: coverage-7efc
[908.414649] Starting dynamic subtest: pipe-A-eDP-1
[909.020626] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s)
[909.049751] Starting dynamic subtest: pipe-D-eDP-1
[910.310018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[910.310892] Subtest coverage-7efc: SUCCESS (2.209s)
[911.126904] [125/133] (126s left) i915_drm_fdinfo (memory-info-idle)
[911.168805] Starting subtest: memory-info-idle
[911.169720] Starting dynamic subtest: smem0
[911.230092] Dynamic subtest smem0: SUCCESS (0.061s)
[911.231517] Subtest memory-info-idle: SUCCESS (0.061s)
[911.275964] [126/133] (126s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[911.373313] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[911.374370] Starting dynamic subtest: pipe-A-eDP-1
[911.473004] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[911.485411] Starting dynamic subtest: pipe-B-eDP-1
[912.630028] Dynamic subtest pipe-B-eDP-1: SKIP (1.155s)
[912.631812] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.259s)
[913.796645] [127/133] (123s left) vgem_slow (nohang)
[913.839104] Starting subtest: nohang
[924.325486] Subtest nohang: SUCCESS (10.447s)
[924.357334] [128/133] (113s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[924.442134] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[924.443890] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[924.486986] [129/133] (112s left) syncobj_wait (wait-all-delayed-signal)
[924.535404] Starting subtest: wait-all-delayed-signal
[924.638221] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[924.690173] [130/133] (112s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[924.782586] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[924.784504] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[924.829275] [131/133] (112s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[924.927699] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[924.928651] Starting dynamic subtest: pipe-A-eDP-1
[924.936798] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[924.946113] Starting dynamic subtest: pipe-B-eDP-1
[924.954399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[924.963572] Starting dynamic subtest: pipe-C-eDP-1
[924.971406] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[924.980273] Starting dynamic subtest: pipe-D-eDP-1
[924.988580] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[924.990249] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[927.157008] [132/133] (110s left) kms_getfb (getfb-handle-closed)
[927.255827] Starting subtest: getfb-handle-closed
[927.256734] Subtest getfb-handle-closed: SUCCESS (0.000s)
[927.325848] [133/133] (110s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[927.429768] Starting subtest: extended-pageflip-modeset-hang-oldfb
[927.430690] Starting dynamic subtest: pipe-A
[935.339324] Dynamic subtest pipe-A: SUCCESS (7.912s)
[935.348915] Starting dynamic subtest: pipe-D
[943.976721] Dynamic subtest pipe-D: SUCCESS (8.639s)
[943.978995] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.556s)
[944.793854] Closing watchdogs
results: parsing output: 0/ for test: kms_addfb_basic
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_invalid_mode
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_dirtyfb
results: parsing output: 10/ for test: gen7_exec_parse
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_vm_create
results: parsing output: 14/ for test: i915_selftest
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: drm_buddy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: fbdev
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_ctx_engines
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_cursor_edge_walk
results: parsing output: 28/ for test: kms_vrr
results: parsing output: 29/ for test: gem_render_copy
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_getfb
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_exec_balancer
results: parsing output: 39/ for test: kms_setmode
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_color
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_chamelium_color
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_force_connector_basic
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_cursor_legacy
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: core_auth
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: syncobj_basic
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: sw_sync
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: sriov_basic
results: parsing output: 73/ for test: i915_pm_freq_api
results: parsing output: 74/ for test: gem_exec_nop
results: parsing output: 75/ for test: kms_rotation_crc
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_pm_dc
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gem_sync
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: gem_ctx_isolation
results: parsing output: 89/ for test: kms_async_flips
results: parsing output: 90/ for test: i915_pm_rps
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: gem_render_copy
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_gpgpu_fill
results: parsing output: 105/ for test: kms_atomic
results: parsing output: 106/ for test: gem_pread
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: gem_exec_alignment
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_madvise
results: parsing output: 116/ for test: kms_dsc
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_ccs
results: parsing output: 119/ for test: gem_mmap_offset
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_plane_alpha_blend
results: parsing output: 124/ for test: i915_drm_fdinfo
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: vgem_slow
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_plane
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: kms_getfb
results: parsing output: 132/ for test: kms_busy
Done.