[56.196739] Initializing watchdogs
[56.196786]   /dev/watchdog0
[56.211010] [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]
[56.215538] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.217981] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.221289] [001/133] (960s left) kms_addfb_basic (basic)
[56.304270] Starting subtest: basic
[56.306150] Subtest basic: SUCCESS (0.000s)
[56.465717] [002/133] (960s left) gem_userptr_blits (unsync-unmap-after-close)
[56.531934] Subtest unsync-unmap-after-close: SKIP (0.000s)
[56.684336] [003/133] (960s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[56.744886] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[56.837738] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[56.942104] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[56.946405] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[57.049120] [005/133] (959s left) kms_invalid_mode (bad-hsync-start)
[57.151670] Starting subtest: bad-hsync-start
[57.153500] Starting dynamic subtest: pipe-A-eDP-1
[57.437033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[57.444427] Starting dynamic subtest: pipe-B-eDP-1
[57.446608] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[57.453166] Starting dynamic subtest: pipe-C-eDP-1
[57.455293] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[57.461756] Starting dynamic subtest: pipe-D-eDP-1
[57.463632] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[57.465728] Subtest bad-hsync-start: SUCCESS (0.289s)
[58.256924] [006/133] (958s left) gem_exec_schedule (implicit-read-write)
[58.330551] Starting subtest: implicit-read-write
[58.332532] Starting dynamic subtest: rcs0
[58.434053] Dynamic subtest rcs0: SUCCESS (0.107s)
[58.444708] Starting dynamic subtest: vcs0
[58.512664] Dynamic subtest vcs0: SUCCESS (0.079s)
[58.521274] Starting dynamic subtest: vcs1
[58.588079] Dynamic subtest vcs1: SUCCESS (0.075s)
[58.597843] Starting dynamic subtest: vecs0
[58.661657] Dynamic subtest vecs0: SUCCESS (0.074s)
[58.670685] Starting dynamic subtest: ccs0
[58.742922] Dynamic subtest ccs0: SUCCESS (0.080s)
[58.745604] Subtest implicit-read-write: SUCCESS (0.417s)
[60.047469] [007/133] (956s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[60.143049] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[60.145368] Starting dynamic subtest: pipe-A-eDP-1
[60.169770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[60.178492] Starting dynamic subtest: pipe-B-eDP-1
[60.201632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[60.209023] Starting dynamic subtest: pipe-C-eDP-1
[60.232436] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[60.239317] Starting dynamic subtest: pipe-D-eDP-1
[60.270772] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[60.274811] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[62.308204] [008/133] (954s left) syncobj_timeline (wait-for-submit-snapshot)
[62.371300] Starting subtest: wait-for-submit-snapshot
[62.452029] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[62.544763] [009/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[62.643651] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[70.028165] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.400s)
[70.197345] [010/133] (946s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[70.305867] Starting subtest: psr-dirtyfb-ioctl
[70.308163] Starting dynamic subtest: A-eDP-1
[74.210534] Dynamic subtest A-eDP-1: SUCCESS (3.907s)
[74.212599] Subtest psr-dirtyfb-ioctl: SUCCESS (3.908s)
[75.005202] [011/133] (942s left) gen7_exec_parse (basic-offset)
[75.076668] Subtest basic-offset: SKIP (0.000s)
[75.155948] [012/133] (941s left) kms_psr (pr-cursor-render)
[75.252426] Starting subtest: pr-cursor-render
[75.258687] Subtest pr-cursor-render: SKIP (0.000s)
[75.363401] [013/133] (941s left) kms_psr (psr-primary-render)
[75.465742] Starting subtest: psr-primary-render
[75.468026] Starting dynamic subtest: eDP-1
[77.201358] Dynamic subtest eDP-1: SUCCESS (1.735s)
[77.203430] Subtest psr-primary-render: SUCCESS (1.736s)
[78.068642] [014/133] (939s left) gem_vm_create (isolation)
[78.130723] Starting subtest: isolation
[78.139121] Subtest isolation: SUCCESS (0.008s)
[78.301427] [015/133] (938s left) i915_selftest (live)
[81.701231] Starting subtest: live
[81.703909] Starting dynamic subtest: sanitycheck
[86.124583] Dynamic subtest sanitycheck: SUCCESS (4.422s)
[86.132803] Starting dynamic subtest: uncore
[90.703928] Dynamic subtest uncore: SUCCESS (4.578s)
[90.712429] Starting dynamic subtest: workarounds
[94.052188] Dynamic subtest workarounds: SUCCESS (3.347s)
[94.060300] Starting dynamic subtest: gt_engines
[98.765044] Dynamic subtest gt_engines: SUCCESS (4.712s)
[98.773451] Starting dynamic subtest: gt_timelines
[114.711323] Dynamic subtest gt_timelines: SUCCESS (15.941s)
[114.719847] Starting dynamic subtest: gt_contexts
[119.178467] Dynamic subtest gt_contexts: SUCCESS (4.468s)
[119.187710] Starting dynamic subtest: gt_lrc
[125.423684] Dynamic subtest gt_lrc: SUCCESS (6.244s)
[125.432506] Starting dynamic subtest: gt_mocs
[128.583351] Dynamic subtest gt_mocs: SUCCESS (3.159s)
[128.596366] Starting dynamic subtest: gt_pm
[135.557391] Dynamic subtest gt_pm: SUCCESS (6.972s)
[135.566041] Starting dynamic subtest: gt_heartbeat
[140.048432] Dynamic subtest gt_heartbeat: SUCCESS (4.491s)
[140.057598] Starting dynamic subtest: gt_tlb
[149.593316] Dynamic subtest gt_tlb: SUCCESS (9.539s)
[149.602657] Starting dynamic subtest: requests
[161.094639] Dynamic subtest requests: SUCCESS (11.502s)
[161.103732] Starting dynamic subtest: migrate
[169.205342] Dynamic subtest migrate: SUCCESS (8.109s)
[169.214108] Starting dynamic subtest: active
[173.642581] Dynamic subtest active: SUCCESS (4.436s)
[173.656166] Starting dynamic subtest: objects
[177.099808] Dynamic subtest objects: SUCCESS (3.456s)
[177.108458] Starting dynamic subtest: mman
[182.132585] Dynamic subtest mman: SUCCESS (5.031s)
[182.141936] Starting dynamic subtest: dmabuf
[186.662419] Dynamic subtest dmabuf: SUCCESS (4.528s)
[186.671529] Starting dynamic subtest: vma
[191.075797] Dynamic subtest vma: SUCCESS (4.412s)
[191.084911] Starting dynamic subtest: coherency
[196.179099] Dynamic subtest coherency: SUCCESS (5.102s)
[196.187571] Starting dynamic subtest: gtt
[206.427294] Dynamic subtest gtt: SUCCESS (10.246s)
[206.435197] Starting dynamic subtest: gem
[214.778542] Dynamic subtest gem: SUCCESS (8.346s)
[214.786990] Starting dynamic subtest: evict
[218.984544] Dynamic subtest evict: SUCCESS (4.207s)
[218.993414] Starting dynamic subtest: hugepages
[228.087231] Dynamic subtest hugepages: SUCCESS (9.101s)
[228.096257] Starting dynamic subtest: gem_contexts
[254.802397] Dynamic subtest gem_contexts: SUCCESS (26.712s)
[254.811050] Starting dynamic subtest: client
[259.264460] Dynamic subtest client: SUCCESS (4.461s)
[259.273363] Starting dynamic subtest: gem_migrate
[263.733305] Dynamic subtest gem_migrate: SUCCESS (4.468s)
[263.742286] Starting dynamic subtest: reset
[266.668545] Dynamic subtest reset: SUCCESS (2.932s)
[266.677886] Starting dynamic subtest: memory_region
[271.444543] Dynamic subtest memory_region: SUCCESS (4.773s)
[271.453438] Starting dynamic subtest: hangcheck
[284.609538] Dynamic subtest hangcheck: SUCCESS (13.163s)
[284.618670] Starting dynamic subtest: execlists
[289.103448] Dynamic subtest execlists: SUCCESS (4.492s)
[289.112590] Starting dynamic subtest: ring_submission
[293.532582] Dynamic subtest ring_submission: SUCCESS (4.428s)
[293.541473] Starting dynamic subtest: perf
[297.995533] Dynamic subtest perf: SUCCESS (4.460s)
[298.004492] Starting dynamic subtest: slpc
[312.267222] Dynamic subtest slpc: SUCCESS (14.269s)
[312.274012] Starting dynamic subtest: guc
[316.309382] Dynamic subtest guc: SUCCESS (4.040s)
[316.318729] Starting dynamic subtest: guc_multi_lrc
[320.719241] Dynamic subtest guc_multi_lrc: SUCCESS (4.407s)
[320.727445] Starting dynamic subtest: guc_hang
[325.785879] Dynamic subtest guc_hang: SUCCESS (5.065s)
[325.800930] Starting dynamic subtest: late_gt_pm
[330.301074] Dynamic subtest late_gt_pm: SUCCESS (4.491s)
[330.305806] Subtest live: SUCCESS (248.570s)
[330.334960] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[330.338202] [016/133] (686s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[331.920787] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[336.233933] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.316s)
[337.467099] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[337.470924] [017/133] (679s left) gem_userptr_blits (readonly-unsync)
[337.543803] Subtest readonly-unsync: SKIP (0.000s)
[337.681397] [018/133] (679s left) drm_buddy (drm_buddy)
[337.719151] Starting subtest: drm_buddy
[337.723428] Subtest drm_buddy: SKIP (0.001s)
[337.797164] [019/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[337.906856] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[337.910759] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[338.039512] [020/133] (679s left) fbdev (read)
[338.079976] Starting subtest: read
[338.608364] Subtest read: SUCCESS (0.526s)
[338.682537] [021/133] (678s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[338.782194] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[338.786415] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[338.907707] [022/133] (678s left) kms_vblank (ts-continuation-suspend)
[339.003780] Starting subtest: ts-continuation-suspend
[339.005616] Starting dynamic subtest: pipe-A-eDP-1
[355.218656] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.368s)
[355.233250] Starting dynamic subtest: pipe-D-eDP-1
[372.220421] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.217s)
[372.222722] Subtest ts-continuation-suspend: SUCCESS (4.588s)
[373.025165] [023/133] (644s left) kms_cursor_crc (cursor-random-64x64)
[373.240465] Starting subtest: cursor-random-64x64
[373.245380] Starting dynamic subtest: pipe-A-eDP-1
[376.570202] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.363s)
[376.596276] Starting dynamic subtest: pipe-D-eDP-1
[380.529273] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.970s)
[380.531622] Subtest cursor-random-64x64: SUCCESS (7.363s)
[381.407637] [024/133] (636s left) gem_ctx_engines (independent)
[381.479024] Starting subtest: independent
[381.481320] Starting dynamic subtest: rcs0
[381.622255] Dynamic subtest rcs0: SUCCESS (0.142s)
[381.632098] Starting dynamic subtest: bcs0
[381.726749] Dynamic subtest bcs0: SUCCESS (0.105s)
[381.738077] Starting dynamic subtest: vcs0
[381.845840] Dynamic subtest vcs0: SUCCESS (0.118s)
[381.856405] Starting dynamic subtest: vcs1
[381.957305] Dynamic subtest vcs1: SUCCESS (0.112s)
[381.967357] Starting dynamic subtest: vecs0
[382.065974] Dynamic subtest vecs0: SUCCESS (0.108s)
[382.074326] Starting dynamic subtest: ccs0
[382.202865] Dynamic subtest ccs0: SUCCESS (0.136s)
[382.211974] Starting dynamic subtest: all-engines
[382.760303] Dynamic subtest all-engines: SUCCESS (0.559s)
[382.762625] Subtest independent: SUCCESS (1.288s)
[383.648821] [025/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[383.760723] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[390.547935] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.811s)
[390.714755] [026/133] (626s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[390.830146] Starting subtest: fbc-modesetfrombusy
[394.566025] Subtest fbc-modesetfrombusy: SUCCESS (3.745s)
[395.771601] [027/133] (621s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[395.820773] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[395.929307] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[396.016199] [028/133] (621s left) kms_cursor_edge_walk (256x256-top-edge)
[396.104250] Starting subtest: 256x256-top-edge
[396.106441] Starting dynamic subtest: pipe-A-eDP-1
[399.565730] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[399.574363] Starting dynamic subtest: pipe-D-eDP-1
[402.686122] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[402.688344] Subtest 256x256-top-edge: SUCCESS (6.588s)
[403.513440] [029/133] (614s left) kms_vrr (seamless-rr-switch-virtual)
[403.618326] Starting subtest: seamless-rr-switch-virtual
[403.624694] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[403.697040] [030/133] (614s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[403.761186] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[403.765878] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[403.955792] [031/133] (613s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[404.056075] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[404.060223] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[404.185916] [032/133] (613s left) kms_big_fb (linear-32bpp-rotate-270)
[404.298934] Starting subtest: linear-32bpp-rotate-270
[404.318413] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[404.465350] [033/133] (613s left) kms_getfb (getfb2-handle-protection)
[404.566477] Starting subtest: getfb2-handle-protection
[404.604183] Subtest getfb2-handle-protection: SUCCESS (0.038s)
[404.747354] [034/133] (613s left) kms_pm_rpm (system-suspend-modeset)
[406.676201] Starting subtest: system-suspend-modeset
[426.165651] Subtest system-suspend-modeset: SUCCESS (4.341s)
[426.542728] [035/133] (591s left) syncobj_timeline (invalid-signal-illegal-handle)
[426.602371] Starting subtest: invalid-signal-illegal-handle
[426.604563] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[426.701601] [036/133] (591s left) kms_chamelium_hpd (common-hpd-after-suspend)
[427.075482] Subtest common-hpd-after-suspend: SKIP (0.000s)
[427.900358] [037/133] (590s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[427.997344] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[428.001924] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[429.140082] [038/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[429.240041] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[429.244302] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[429.354736] [039/133] (588s left) gem_exec_balancer (smoke)
[429.415523] Starting subtest: smoke
[451.965794] Subtest smoke: SUCCESS (22.580s)
[453.051690] [040/133] (565s left) kms_setmode (basic)
[453.118916] Starting subtest: basic
[453.446826] Starting dynamic subtest: pipe-A-eDP-1
[457.035772] Dynamic subtest pipe-A-eDP-1: FAIL (3.481s)
[457.266954] Starting dynamic subtest: pipe-B-eDP-1
[460.857099] Dynamic subtest pipe-B-eDP-1: FAIL (3.465s)
[461.030183] Subtest basic: FAIL (7.908s)
[461.839354] [041/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[461.946874] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[461.951195] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[462.059968] [042/133] (556s left) kms_color (deep-color)
[462.150039] Starting subtest: deep-color
[463.195508] Starting dynamic subtest: pipe-A-eDP-1-gamma
[463.904069] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.709s)
[463.915252] Starting dynamic subtest: pipe-A-eDP-1-degamma
[465.384195] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.478s)
[465.392875] Starting dynamic subtest: pipe-A-eDP-1-ctm
[466.857713] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.471s)
[467.604826] Starting dynamic subtest: pipe-B-eDP-1-gamma
[468.313219] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.713s)
[468.328150] Starting dynamic subtest: pipe-B-eDP-1-degamma
[469.799497] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.485s)
[469.808719] Starting dynamic subtest: pipe-B-eDP-1-ctm
[471.223634] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.422s)
[472.007745] Starting dynamic subtest: pipe-C-eDP-1-gamma
[472.690416] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[472.700290] Starting dynamic subtest: pipe-C-eDP-1-degamma
[474.081016] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.388s)
[474.090010] Starting dynamic subtest: pipe-C-eDP-1-ctm
[475.478292] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.397s)
[476.306427] Starting dynamic subtest: pipe-D-eDP-1-gamma
[477.005206] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s)
[477.015098] Starting dynamic subtest: pipe-D-eDP-1-degamma
[478.472271] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.466s)
[478.481435] Starting dynamic subtest: pipe-D-eDP-1-ctm
[479.888645] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.417s)
[479.890929] Subtest deep-color: SUCCESS (17.732s)
[480.776259] [043/133] (537s left) gem_lmem_swapping (parallel-random-verify)
[480.828176] Subtest parallel-random-verify: SKIP (0.000s)
[480.874019] [044/133] (537s left) kms_flip (dpms-vs-vblank-race)
[480.968770] Starting subtest: dpms-vs-vblank-race
[480.971003] Starting dynamic subtest: A-eDP1
[485.942215] Dynamic subtest A-eDP1: SUCCESS (4.972s)
[485.951844] Starting dynamic subtest: B-eDP1
[489.457502] Dynamic subtest B-eDP1: SUCCESS (3.512s)
[489.467118] Starting dynamic subtest: C-eDP1
[494.099456] Dynamic subtest C-eDP1: SUCCESS (4.643s)
[494.108452] Starting dynamic subtest: D-eDP1
[498.709388] Dynamic subtest D-eDP1: SUCCESS (4.607s)
[498.711790] Subtest dpms-vs-vblank-race: SUCCESS (17.742s)
[499.598864] [045/133] (518s left) kms_chamelium_color (degamma)
[499.701727] Subtest degamma: SKIP (0.000s)
[499.743737] [046/133] (518s left) api_intel_bb (add-remove-objects)
[499.802970] Starting subtest: add-remove-objects
[499.810548] Subtest add-remove-objects: SUCCESS (0.010s)
[499.951544] [047/133] (518s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[500.060086] Starting subtest: cursor-vs-flip-atomic
[529.472679] Subtest cursor-vs-flip-atomic: SUCCESS (29.417s)
[530.318332] [048/133] (488s left) gem_userptr_blits (readonly-pwrite-unsync)
[530.393719] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[530.536623] [049/133] (488s left) gem_exec_schedule (wide)
[530.724243] Starting subtest: wide
[530.726649] Starting dynamic subtest: rcs0
[541.017969] Dynamic subtest rcs0: SUCCESS (10.244s)
[541.030203] Starting dynamic subtest: vcs0
[551.697876] Dynamic subtest vcs0: SUCCESS (10.733s)
[551.709775] Starting dynamic subtest: vcs1
[561.882068] Dynamic subtest vcs1: SUCCESS (10.185s)
[561.894009] Starting dynamic subtest: vecs0
[571.782317] Dynamic subtest vecs0: SUCCESS (9.902s)
[571.793744] Starting dynamic subtest: ccs0
[584.530975] Dynamic subtest ccs0: SUCCESS (12.697s)
[584.533214] Subtest wide: SUCCESS (53.769s)
[585.962551] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[585.966686] [050/133] (432s left) kms_force_connector_basic (force-load-detect)
[586.056829] Starting subtest: force-load-detect
[586.061162] Subtest force-load-detect: SKIP (0.000s)
[586.187421] [051/133] (432s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[586.237398] Starting subtest: multi-wait-all-for-submit-submitted
[586.342584] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[586.429199] [052/133] (432s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[586.544901] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[603.889450] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.349s)
[604.695719] [053/133] (414s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[604.810061] Starting subtest: yf-tiled-8bpp-rotate-270
[604.814236] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[604.932498] [054/133] (413s left) core_auth (getclient-simple)
[604.972299] Starting subtest: getclient-simple
[604.991043] Subtest getclient-simple: SUCCESS (0.019s)
[605.106644] [055/133] (413s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[605.206917] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[605.210837] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[605.334760] [056/133] (413s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[605.456604] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[605.460911] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[605.574658] [057/133] (413s left) gem_exec_reloc (basic-wc)
[605.639638] Subtest basic-wc: SKIP (0.000s)
[605.726431] [058/133] (413s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[605.837398] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[605.841038] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[605.968037] [059/133] (413s left) syncobj_basic (illegal-fd-to-handle)
[606.016345] Starting subtest: illegal-fd-to-handle
[606.018157] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[606.141276] [060/133] (412s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[606.235768] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[606.239195] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[606.315624] [061/133] (412s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[606.415471] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[606.418810] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[606.532234] [062/133] (412s left) kms_flip (wf_vblank-ts-check)
[606.643867] Starting subtest: wf_vblank-ts-check
[606.647897] Starting dynamic subtest: A-eDP1
[615.660663] Dynamic subtest A-eDP1: SUCCESS (8.983s)
[615.671750] Starting dynamic subtest: B-eDP1
[624.595267] Dynamic subtest B-eDP1: SUCCESS (8.928s)
[624.606641] Starting dynamic subtest: C-eDP1
[633.522766] Dynamic subtest C-eDP1: SUCCESS (8.913s)
[633.534270] Starting dynamic subtest: D-eDP1
[642.456483] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[642.458430] Subtest wf_vblank-ts-check: SUCCESS (35.767s)
[643.648983] [063/133] (375s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[643.747286] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[643.749522] Starting dynamic subtest: pipe-A-eDP-1
[643.772132] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[643.782985] Starting dynamic subtest: pipe-B-eDP-1
[643.803670] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[643.812549] Starting dynamic subtest: pipe-C-eDP-1
[643.833546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[643.842767] Starting dynamic subtest: pipe-D-eDP-1
[643.866395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[643.871152] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[645.940185] [064/133] (373s left) kms_psr (fbc-pr-cursor-blt)
[646.034412] Starting subtest: fbc-pr-cursor-blt
[646.038674] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[646.119294] [065/133] (373s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[646.216764] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[646.218930] Starting dynamic subtest: pipe-A
[646.236633] Dynamic subtest pipe-A: SKIP (0.017s)
[646.247741] Starting dynamic subtest: pipe-B
[646.266867] Dynamic subtest pipe-B: SKIP (0.030s)
[646.276018] Starting dynamic subtest: pipe-C
[646.295703] Dynamic subtest pipe-C: SKIP (0.029s)
[646.304444] Starting dynamic subtest: pipe-D
[646.327182] Dynamic subtest pipe-D: SKIP (0.029s)
[646.331318] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.107s)
[646.436221] [066/133] (372s left) sw_sync (alloc_timeline)
[646.476330] Starting subtest: alloc_timeline
[646.478428] Subtest alloc_timeline: SUCCESS (0.000s)
[646.543858] [067/133] (372s left) kms_selftest (drm_format_helper)
[646.582055] Starting subtest: drm_format_helper
[646.628062] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[646.753959] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.124s)
[646.768683] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[646.863656] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.110s)
[646.872678] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[647.008775] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.143s)
[647.017257] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[647.155649] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.146s)
[647.164213] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[647.311833] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.156s)
[647.322424] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[647.457776] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.144s)
[647.467461] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[647.599958] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.142s)
[647.608905] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[647.747876] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.148s)
[647.756697] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[647.876687] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.125s)
[647.887061] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[648.025638] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.148s)
[648.036451] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[648.120989] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.093s)
[648.130368] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[648.247715] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.128s)
[648.256560] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[648.411659] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.161s)
[648.420244] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[648.561884] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.149s)
[648.570621] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[648.706893] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.145s)
[648.715408] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[648.854083] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.148s)
[648.863004] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[649.015234] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.160s)
[649.017633] Subtest drm_format_helper: SUCCESS (2.434s)
[649.245612] [068/133] (370s left) gem_userptr_blits (sync-unmap-cycles)
[649.321887] Starting subtest: sync-unmap-cycles
[654.702387] Subtest sync-unmap-cycles: SUCCESS (5.382s)
[654.871619] [069/133] (364s left) perf_pmu (rc6)
[654.909239] Starting subtest: rc6
[654.911244] Starting dynamic subtest: gt0
[661.264172] Dynamic subtest gt0: SUCCESS (6.352s)
[661.276396] Starting dynamic subtest: runtime-pm-gt0
[669.041689] Dynamic subtest runtime-pm-gt0: SUCCESS (7.775s)
[669.053375] Starting dynamic subtest: runtime-pm-long-gt0
[681.518998] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.474s)
[681.529294] Starting dynamic subtest: other-idle-gt0
[687.864225] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[687.876499] Starting dynamic subtest: gt1
[694.257022] Dynamic subtest gt1: SUCCESS (6.339s)
[694.268641] Starting dynamic subtest: runtime-pm-gt1
[701.629615] Dynamic subtest runtime-pm-gt1: SUCCESS (7.421s)
[701.641637] Starting dynamic subtest: runtime-pm-long-gt1
[714.117656] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.486s)
[714.130087] Starting dynamic subtest: other-idle-gt1
[720.461279] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[720.464337] Subtest rc6: SUCCESS (65.549s)
[721.603199] [070/133] (297s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[721.714721] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[721.725862] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[721.847680] [071/133] (297s left) gem_exec_reloc (basic-cpu)
[721.916857] Subtest basic-cpu: SKIP (0.000s)
[722.000450] [072/133] (297s left) kms_psr (psr2-primary-mmap-cpu)
[722.097505] Starting subtest: psr2-primary-mmap-cpu
[722.099370] Starting dynamic subtest: eDP-1
[723.820103] Dynamic subtest eDP-1: SUCCESS (1.723s)
[723.822505] Subtest psr2-primary-mmap-cpu: SUCCESS (1.724s)
[724.679180] [073/133] (294s left) sriov_basic (enable-vfs-autoprobe-on)
[724.746908] Starting subtest: enable-vfs-autoprobe-on
[724.749122] Starting dynamic subtest: numvfs-1
[724.820710] Dynamic subtest numvfs-1: FAIL (0.005s)
[724.831680] Starting dynamic subtest: numvfs-2
[724.903198] Dynamic subtest numvfs-2: FAIL (0.004s)
[724.913982] Starting dynamic subtest: numvfs-3
[724.986362] Dynamic subtest numvfs-3: FAIL (0.004s)
[724.996536] Starting dynamic subtest: numvfs-4
[725.068359] Dynamic subtest numvfs-4: FAIL (0.004s)
[725.078958] Starting dynamic subtest: numvfs-5
[725.150900] Dynamic subtest numvfs-5: FAIL (0.004s)
[725.161442] Starting dynamic subtest: numvfs-6
[725.233629] Dynamic subtest numvfs-6: FAIL (0.004s)
[725.244479] Starting dynamic subtest: numvfs-7
[725.316743] Dynamic subtest numvfs-7: FAIL (0.004s)
[725.327298] Starting dynamic subtest: numvfs-random
[725.398380] Dynamic subtest numvfs-random: FAIL (0.004s)
[725.409274] Starting dynamic subtest: numvfs-all
[725.482052] Dynamic subtest numvfs-all: FAIL (0.510s)
[725.484075] Subtest enable-vfs-autoprobe-on: FAIL (0.548s)
[725.524095] [074/133] (294s left) i915_pm_freq_api (freq-reset)
[725.581206] Starting subtest: freq-reset
[725.583424] Starting dynamic subtest: gt0
[725.779789] Dynamic subtest gt0: SUCCESS (0.196s)
[725.789327] Starting dynamic subtest: gt1
[725.948419] Dynamic subtest gt1: SUCCESS (0.168s)
[725.950783] Subtest freq-reset: SUCCESS (0.366s)
[726.003377] [075/133] (293s left) gem_exec_nop (basic-parallel)
[726.085223] Starting subtest: basic-parallel
[742.747752] Subtest basic-parallel: SUCCESS (16.674s)
[742.978266] [076/133] (276s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[743.087153] Starting subtest: primary-y-tiled-reflect-x-180
[743.157887] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[743.241336] [077/133] (276s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[743.342650] Starting subtest: fbc-psr2-cursor-plane-update-sf
[743.344823] Starting dynamic subtest: pipe-A-eDP-1
[743.416857] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[743.430102] Starting dynamic subtest: pipe-B-eDP-1
[744.566783] Dynamic subtest pipe-B-eDP-1: SKIP (1.147s)
[744.571471] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.227s)
[745.845771] [078/133] (273s left) syncobj_timeline (reset-multiple-signaled)
[745.904026] Starting subtest: reset-multiple-signaled
[745.905965] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[746.001816] [079/133] (273s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[746.113966] Starting subtest: 4-tiled-8bpp-rotate-270
[746.137375] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[746.249133] [080/133] (273s left) gem_spin_batch (resubmit-new)
[746.304153] Starting subtest: resubmit-new
[746.306374] Starting dynamic subtest: rcs0
[746.311774] Dynamic subtest rcs0: SUCCESS (0.007s)
[746.323095] Starting dynamic subtest: bcs0
[746.325211] Dynamic subtest bcs0: SUCCESS (0.004s)
[746.334781] Starting dynamic subtest: vcs0
[746.337025] Dynamic subtest vcs0: SUCCESS (0.005s)
[746.346252] Starting dynamic subtest: vcs1
[746.348072] Dynamic subtest vcs1: SUCCESS (0.006s)
[746.356889] Starting dynamic subtest: vecs0
[746.358709] Dynamic subtest vecs0: SUCCESS (0.004s)
[746.367667] Starting dynamic subtest: ccs0
[746.369514] Dynamic subtest ccs0: SUCCESS (0.003s)
[746.371332] Subtest resubmit-new: SUCCESS (0.034s)
[747.760375] [081/133] (272s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[747.868958] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[748.892555] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.024s)
[748.993627] [082/133] (271s left) kms_pm_dc (dc3co-vpb-simulation)
[750.095432] Starting subtest: dc3co-vpb-simulation
[758.645899] Subtest dc3co-vpb-simulation: SKIP (8.547s)
[758.767897] [083/133] (261s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[758.871250] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[758.875371] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[758.966378] [084/133] (261s left) perf_pmu (init-busy)
[759.006899] Starting subtest: init-busy
[759.009137] Starting dynamic subtest: rcs0
[759.011328] Dynamic subtest rcs0: SUCCESS (0.001s)
[759.021698] Starting dynamic subtest: bcs0
[759.023781] Dynamic subtest bcs0: SUCCESS (0.000s)
[759.033398] Starting dynamic subtest: vcs0
[759.035196] Dynamic subtest vcs0: SUCCESS (0.001s)
[759.044423] Starting dynamic subtest: vcs1
[759.046285] Dynamic subtest vcs1: SUCCESS (0.001s)
[759.055318] Starting dynamic subtest: vecs0
[759.057190] Dynamic subtest vecs0: SUCCESS (0.001s)
[759.066050] Starting dynamic subtest: ccs0
[759.067840] Dynamic subtest ccs0: SUCCESS (0.000s)
[759.069679] Subtest init-busy: SUCCESS (0.008s)
[759.109257] [085/133] (261s left) gem_sync (basic-all)
[759.191876] Starting subtest: basic-all
[762.716684] Subtest basic-all: SUCCESS (3.534s)
[762.879488] [086/133] (257s left) syncobj_wait (single-wait-for-submit-submitted)
[762.931107] Starting subtest: single-wait-for-submit-submitted
[763.038320] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[763.094915] [087/133] (257s left) gem_exec_reloc (basic-active)
[763.154201] Subtest basic-active: SKIP (0.000s)
[763.248228] [088/133] (256s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[763.352427] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[763.354706] Starting dynamic subtest: pipe-A
[763.375864] Dynamic subtest pipe-A: SKIP (0.018s)
[763.387551] Starting dynamic subtest: pipe-B
[763.404539] Dynamic subtest pipe-B: SKIP (0.030s)
[763.414512] Starting dynamic subtest: pipe-C
[763.437460] Dynamic subtest pipe-C: SKIP (0.031s)
[763.447087] Starting dynamic subtest: pipe-D
[763.467127] Dynamic subtest pipe-D: SKIP (0.031s)
[763.470855] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.112s)
[763.534313] [089/133] (256s left) gem_ctx_isolation (nonpriv)
[763.609828] Starting subtest: nonpriv
[763.611743] Starting dynamic subtest: rcs0
[763.851880] Dynamic subtest rcs0: SUCCESS (0.245s)
[763.864903] Starting dynamic subtest: bcs0
[764.105473] Dynamic subtest bcs0: SUCCESS (0.253s)
[764.118011] Starting dynamic subtest: vcs0
[764.358231] Dynamic subtest vcs0: SUCCESS (0.252s)
[764.370023] Starting dynamic subtest: vcs1
[765.976255] Dynamic subtest vcs1: SUCCESS (1.617s)
[765.986683] Starting dynamic subtest: vecs0
[768.026116] Dynamic subtest vecs0: SUCCESS (2.049s)
[768.037531] Starting dynamic subtest: ccs0
[770.064136] Dynamic subtest ccs0: SUCCESS (2.038s)
[770.066520] Subtest nonpriv: SUCCESS (6.459s)
[770.262227] [090/133] (250s left) kms_async_flips (crc)
[770.367683] Starting subtest: crc
[770.740023] Starting dynamic subtest: pipe-A-eDP-1
[773.692660] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[774.076316] Starting dynamic subtest: pipe-B-eDP-1
[777.047621] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.965s)
[777.399414] Starting dynamic subtest: pipe-C-eDP-1
[780.323575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.938s)
[780.687336] Starting dynamic subtest: pipe-D-eDP-1
[783.574515] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.869s)
[783.576753] Subtest crc: SUCCESS (13.182s)
[784.693781] [091/133] (235s left) i915_pm_rps (engine-order)
[784.760449] Starting subtest: engine-order
[789.814227] Subtest engine-order: SUCCESS (5.054s)
[789.920652] [092/133] (230s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[790.012107] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[794.598245] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.589s)
[795.697622] [093/133] (224s left) gem_exec_fence (parallel)
[795.881142] Starting subtest: parallel
[795.883151] Starting dynamic subtest: rcs0
[798.030329] Dynamic subtest rcs0: SUCCESS (2.153s)
[798.040970] Starting dynamic subtest: bcs0
[800.185245] Dynamic subtest bcs0: SUCCESS (2.154s)
[800.196452] Starting dynamic subtest: vcs0
[802.334950] Dynamic subtest vcs0: SUCCESS (2.149s)
[802.345971] Starting dynamic subtest: vcs1
[804.483350] Dynamic subtest vcs1: SUCCESS (2.148s)
[804.493834] Starting dynamic subtest: vecs0
[806.634422] Dynamic subtest vecs0: SUCCESS (2.151s)
[806.644345] Starting dynamic subtest: ccs0
[808.787727] Dynamic subtest ccs0: SUCCESS (2.153s)
[808.789703] Subtest parallel: SUCCESS (12.913s)
[809.848519] [094/133] (210s left) syncobj_timeline (wait-all-for-submit-complex)
[809.913627] Starting subtest: wait-all-for-submit-complex
[810.129298] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[810.185826] [095/133] (210s left) kms_lease (lease-invalid-connector)
[810.286088] Starting subtest: lease-invalid-connector
[810.288402] Starting dynamic subtest: pipe-A-eDP-1
[810.290751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[810.300968] Starting dynamic subtest: pipe-B-eDP-1
[810.303315] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[810.312946] Starting dynamic subtest: pipe-C-eDP-1
[810.315240] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[810.324724] Starting dynamic subtest: pipe-D-eDP-1
[810.326883] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[810.329136] Subtest lease-invalid-connector: SUCCESS (0.004s)
[810.367077] [096/133] (210s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[810.436224] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[810.440926] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[810.599187] [097/133] (209s left) kms_psr (fbc-psr2-sprite-plane-move)
[810.690662] Starting subtest: fbc-psr2-sprite-plane-move
[810.692845] Starting dynamic subtest: eDP-1
[810.696864] Dynamic subtest eDP-1: SKIP (0.000s)
[810.700986] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[810.740437] [098/133] (209s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[810.841627] Starting subtest: y-tiled-64bpp-rotate-270
[810.846152] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[810.945176] [099/133] (209s left) gem_exec_schedule (semaphore-noskip)
[811.033902] Starting subtest: semaphore-noskip
[811.437440] Subtest semaphore-noskip: SUCCESS (0.410s)
[811.763784] [100/133] (208s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[811.878842] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[811.883152] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[811.968397] [101/133] (208s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[812.089038] Starting subtest: flip-vs-cursor-busy-crc-atomic
[812.890311] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.802s)
[813.710951] [102/133] (207s left) gem_exec_flush (basic-uc-pro-default)
[813.777398] Starting subtest: basic-uc-pro-default
[819.261908] Subtest basic-uc-pro-default: SUCCESS (5.456s)
[819.401193] [103/133] (201s left) gem_exec_balancer (bonded-dual)
[819.464711] Starting subtest: bonded-dual
[819.469013] Subtest bonded-dual: SKIP (0.000s)
[819.762369] [104/133] (201s left) kms_psr (fbc-pr-sprite-blt)
[819.870530] Starting subtest: fbc-pr-sprite-blt
[819.874724] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[819.922054] [105/133] (201s left) gem_gpgpu_fill (offset-16x16)
[819.988707] Starting subtest: offset-16x16
[819.996100] Subtest offset-16x16: SUCCESS (0.009s)
[820.123747] [106/133] (200s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[820.230479] Starting subtest: plane-primary-overlay-mutable-zpos
[823.663470] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.432s)
[824.818241] [107/133] (196s left) gem_pread (snoop)
[824.883025] Subtest snoop: SKIP (0.000s)
[824.952802] [108/133] (196s left) gem_mmap_gtt (hang-busy)
[825.021178] Subtest hang-busy: SKIP (0.000s)
[825.096595] [109/133] (196s left) gem_mmap_wc (fault-concurrent)
[825.165261] Subtest fault-concurrent: SKIP (0.000s)
[825.237316] [110/133] (195s left) kms_content_protection (suspend-resume)
[825.391858] Starting subtest: suspend-resume
[825.396276] Subtest suspend-resume: SKIP (0.000s)
[825.517288] [111/133] (195s left) gem_exec_alignment (forked)
[825.582641] Starting subtest: forked
[862.809112] Subtest forked: SUCCESS (37.234s)
[863.951790] [112/133] (157s left) syncobj_wait (multi-wait-all-submitted-signaled)
[864.042167] Starting subtest: multi-wait-all-submitted-signaled
[864.151434] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[864.204308] [113/133] (157s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[864.278065] Starting subtest: invalid-bsd2-flag-on-blt
[864.280362] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[864.367239] [114/133] (156s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[864.483649] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[864.485983] Starting dynamic subtest: pipe-A-default-mode
[865.606199] Dynamic subtest pipe-A-default-mode: SKIP (1.121s)
[865.610657] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.123s)
[865.774752] [115/133] (155s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[865.835298] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[865.934200] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[865.992886] [116/133] (155s left) gem_madvise (dontneed-after-mmap)
[866.031621] Starting subtest: dontneed-after-mmap
[866.063008] Subtest dontneed-after-mmap: SUCCESS (0.036s)
[866.168716] [117/133] (155s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[866.266190] Starting subtest: dsc-fractional-bpp-with-bpc
[866.297403] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[866.339634] [118/133] (155s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[866.448826] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[870.483488] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.040s)
[871.659573] [119/133] (149s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[871.765433] Starting subtest: bad-rotation-90-yf-tiled-ccs
[871.767656] Starting dynamic subtest: pipe-A-eDP-1
[871.789699] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[871.800783] Starting dynamic subtest: pipe-B-eDP-1
[871.822085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[871.831995] Starting dynamic subtest: pipe-C-eDP-1
[871.853293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[871.862920] Starting dynamic subtest: pipe-D-eDP-1
[871.885465] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[871.889567] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[874.013260] [120/133] (147s left) gem_mmap_offset (pf-nonblock)
[874.068569] Starting subtest: pf-nonblock
[874.079891] Subtest pf-nonblock: SUCCESS (0.012s)
[874.178782] [121/133] (147s left) kms_cursor_crc (cursor-offscreen-512x170)
[874.477464] Starting subtest: cursor-offscreen-512x170
[874.482021] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[874.604553] [122/133] (147s left) sw_sync (sync_multi_timeline_wait)
[874.647146] Starting subtest: sync_multi_timeline_wait
[874.649377] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[874.691609] [123/133] (147s left) gem_ctx_persistence (processes)
[874.752064] Starting subtest: processes
[876.715802] Subtest processes: SUCCESS (1.965s)
[876.775642] [124/133] (144s left) kms_plane_alpha_blend (coverage-7efc)
[876.875793] Starting subtest: coverage-7efc
[877.196064] Starting dynamic subtest: pipe-A-eDP-1
[877.804508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.609s)
[877.832582] Starting dynamic subtest: pipe-D-eDP-1
[879.163202] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[879.165655] Subtest coverage-7efc: SUCCESS (2.286s)
[879.983015] [125/133] (141s left) i915_drm_fdinfo (memory-info-idle)
[880.029621] Starting subtest: memory-info-idle
[880.032077] Starting dynamic subtest: smem0
[880.102088] Dynamic subtest smem0: SUCCESS (0.075s)
[880.104791] Subtest memory-info-idle: SUCCESS (0.076s)
[880.155249] [126/133] (141s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[880.254823] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[880.257053] Starting dynamic subtest: pipe-A-eDP-1
[880.351467] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[880.364097] Starting dynamic subtest: pipe-B-eDP-1
[881.493660] Dynamic subtest pipe-B-eDP-1: SKIP (1.138s)
[881.498413] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.242s)
[882.766699] [127/133] (139s left) vgem_slow (nohang)
[882.818663] Starting subtest: nohang
[892.909255] Subtest nohang: SUCCESS (10.030s)
[892.950467] [128/133] (128s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[893.059849] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[893.064330] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[893.111553] [129/133] (128s left) syncobj_wait (wait-all-delayed-signal)
[893.171746] Starting subtest: wait-all-delayed-signal
[893.274121] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[893.326711] [130/133] (128s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[893.421675] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[893.425876] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[893.470892] [131/133] (128s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[893.569102] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[893.571466] Starting dynamic subtest: pipe-A-eDP-1
[893.594650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[893.606367] Starting dynamic subtest: pipe-B-eDP-1
[893.628181] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[893.638006] Starting dynamic subtest: pipe-C-eDP-1
[893.659097] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[893.668219] Starting dynamic subtest: pipe-D-eDP-1
[893.689497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[893.693749] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[895.826520] [132/133] (126s left) kms_getfb (getfb-handle-closed)
[895.925873] Starting subtest: getfb-handle-closed
[895.928184] Subtest getfb-handle-closed: SUCCESS (0.000s)
[896.016978] [133/133] (126s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[896.114471] Starting subtest: extended-pageflip-modeset-hang-oldfb
[896.116814] Starting dynamic subtest: pipe-A
[904.056054] Dynamic subtest pipe-A: SUCCESS (7.934s)
[904.066875] Starting dynamic subtest: pipe-D
[912.671646] Dynamic subtest pipe-D: SUCCESS (8.610s)
[912.674154] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.549s)
[913.502060] 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.