[60.652900] Initializing watchdogs
[60.652948]   /dev/watchdog0
[60.667392] [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.672166] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.674389] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.676213] [001/133] (960s left) kms_addfb_basic (basic)
[60.751326] Starting subtest: basic
[60.752300] Subtest basic: SUCCESS (0.000s)
[60.927620] [002/133] (960s left) gem_userptr_blits (unsync-unmap-after-close)
[60.985704] Subtest unsync-unmap-after-close: SKIP (0.000s)
[61.107453] [003/133] (960s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[61.163266] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[61.234972] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[61.318009] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[61.319722] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[61.431044] [005/133] (959s left) kms_invalid_mode (bad-hsync-start)
[61.513698] Starting subtest: bad-hsync-start
[61.514567] Starting dynamic subtest: pipe-A-eDP-1
[61.796237] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[61.802549] Starting dynamic subtest: pipe-B-eDP-1
[61.803372] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[61.808584] Starting dynamic subtest: pipe-C-eDP-1
[61.809439] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[61.814448] Starting dynamic subtest: pipe-D-eDP-1
[61.815296] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[61.816122] Subtest bad-hsync-start: SUCCESS (0.288s)
[62.592720] [006/133] (958s left) gem_exec_schedule (implicit-read-write)
[62.659202] Starting subtest: implicit-read-write
[62.659971] Starting dynamic subtest: rcs0
[62.770884] Dynamic subtest rcs0: SUCCESS (0.112s)
[62.777721] Starting dynamic subtest: vcs0
[62.854546] Dynamic subtest vcs0: SUCCESS (0.084s)
[62.860657] Starting dynamic subtest: vcs1
[62.942654] Dynamic subtest vcs1: SUCCESS (0.088s)
[62.948636] Starting dynamic subtest: vecs0
[63.019919] Dynamic subtest vecs0: SUCCESS (0.077s)
[63.030531] Starting dynamic subtest: ccs0
[63.101273] Dynamic subtest ccs0: SUCCESS (0.082s)
[63.102598] Subtest implicit-read-write: SUCCESS (0.444s)
[64.012232] [007/133] (957s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[64.094207] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[64.095068] Starting dynamic subtest: pipe-A-eDP-1
[64.113684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.120156] Starting dynamic subtest: pipe-B-eDP-1
[64.130806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.136810] Starting dynamic subtest: pipe-C-eDP-1
[64.146247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.151739] Starting dynamic subtest: pipe-D-eDP-1
[64.160382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.161923] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[66.331881] [008/133] (955s left) syncobj_timeline (wait-for-submit-snapshot)
[66.385553] Starting subtest: wait-for-submit-snapshot
[66.468206] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[66.549099] [009/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[66.651010] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[74.125836] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.491s)
[74.263922] [010/133] (947s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[74.352333] Starting subtest: psr-dirtyfb-ioctl
[74.353295] Starting dynamic subtest: A-eDP-1
[78.255548] Dynamic subtest A-eDP-1: SUCCESS (3.907s)
[78.256425] Subtest psr-dirtyfb-ioctl: SUCCESS (3.908s)
[79.042588] [011/133] (942s left) gen7_exec_parse (basic-offset)
[79.094621] Subtest basic-offset: SKIP (0.000s)
[79.178518] [012/133] (942s left) kms_psr (pr-cursor-render)
[79.264868] Starting subtest: pr-cursor-render
[79.266853] Subtest pr-cursor-render: SKIP (0.000s)
[79.338056] [013/133] (942s left) kms_psr (psr-primary-render)
[79.433046] Starting subtest: psr-primary-render
[79.433973] Starting dynamic subtest: eDP-1
[81.172022] Dynamic subtest eDP-1: SUCCESS (1.737s)
[81.173154] Subtest psr-primary-render: SUCCESS (1.738s)
[82.024401] [014/133] (939s left) gem_vm_create (isolation)
[82.074619] Starting subtest: isolation
[82.082787] Subtest isolation: SUCCESS (0.008s)
[82.227180] [015/133] (939s left) i915_selftest (live)
[84.059211] Starting subtest: live
[84.060441] Starting dynamic subtest: sanitycheck
[88.495793] Dynamic subtest sanitycheck: SUCCESS (4.426s)
[88.503674] Starting dynamic subtest: uncore
[92.977488] Dynamic subtest uncore: SUCCESS (4.489s)
[92.984751] Starting dynamic subtest: workarounds
[96.304857] Dynamic subtest workarounds: SUCCESS (3.318s)
[96.313084] Starting dynamic subtest: gt_engines
[99.469208] Dynamic subtest gt_engines: SUCCESS (3.164s)
[99.477178] Starting dynamic subtest: gt_timelines
[115.199975] Dynamic subtest gt_timelines: SUCCESS (15.729s)
[115.209935] Starting dynamic subtest: gt_contexts
[119.686277] Dynamic subtest gt_contexts: SUCCESS (4.485s)
[119.692828] Starting dynamic subtest: gt_lrc
[124.126153] Dynamic subtest gt_lrc: SUCCESS (4.438s)
[124.133602] Starting dynamic subtest: gt_mocs
[128.719501] Dynamic subtest gt_mocs: SUCCESS (4.592s)
[128.727152] Starting dynamic subtest: gt_pm
[133.610775] Dynamic subtest gt_pm: SUCCESS (4.890s)
[133.618894] Starting dynamic subtest: gt_heartbeat
[138.055340] Dynamic subtest gt_heartbeat: SUCCESS (4.443s)
[138.063206] Starting dynamic subtest: gt_tlb
[147.514965] Dynamic subtest gt_tlb: SUCCESS (9.459s)
[147.522474] Starting dynamic subtest: requests
[159.151372] Dynamic subtest requests: SUCCESS (11.634s)
[159.159513] Starting dynamic subtest: migrate
[167.224080] Dynamic subtest migrate: SUCCESS (8.071s)
[167.232067] Starting dynamic subtest: active
[171.719399] Dynamic subtest active: SUCCESS (4.493s)
[171.727198] Starting dynamic subtest: objects
[175.152439] Dynamic subtest objects: SUCCESS (3.431s)
[175.160070] Starting dynamic subtest: mman
[180.175931] Dynamic subtest mman: SUCCESS (5.024s)
[180.183887] Starting dynamic subtest: dmabuf
[184.649748] Dynamic subtest dmabuf: SUCCESS (4.472s)
[184.657576] Starting dynamic subtest: vma
[189.165211] Dynamic subtest vma: SUCCESS (4.513s)
[189.172995] Starting dynamic subtest: coherency
[194.250389] Dynamic subtest coherency: SUCCESS (5.084s)
[194.258367] Starting dynamic subtest: gtt
[206.319031] Dynamic subtest gtt: SUCCESS (12.066s)
[206.325859] Starting dynamic subtest: gem
[212.800554] Dynamic subtest gem: SUCCESS (6.480s)
[212.808631] Starting dynamic subtest: evict
[218.359604] Dynamic subtest evict: SUCCESS (5.555s)
[218.367735] Starting dynamic subtest: hugepages
[227.425872] Dynamic subtest hugepages: SUCCESS (9.065s)
[227.433760] Starting dynamic subtest: gem_contexts
[256.140349] Dynamic subtest gem_contexts: SUCCESS (28.712s)
[256.148313] Starting dynamic subtest: client
[259.052328] Dynamic subtest client: SUCCESS (2.910s)
[259.060372] Starting dynamic subtest: gem_migrate
[263.477696] Dynamic subtest gem_migrate: SUCCESS (4.424s)
[263.485483] Starting dynamic subtest: reset
[266.409106] Dynamic subtest reset: SUCCESS (2.929s)
[266.416879] Starting dynamic subtest: memory_region
[270.877617] Dynamic subtest memory_region: SUCCESS (4.467s)
[270.885562] Starting dynamic subtest: hangcheck
[284.117628] Dynamic subtest hangcheck: SUCCESS (13.239s)
[284.125637] Starting dynamic subtest: execlists
[288.550990] Dynamic subtest execlists: SUCCESS (4.430s)
[288.559489] Starting dynamic subtest: ring_submission
[292.991650] Dynamic subtest ring_submission: SUCCESS (4.438s)
[292.999166] Starting dynamic subtest: perf
[297.448690] Dynamic subtest perf: SUCCESS (4.455s)
[297.456570] Starting dynamic subtest: slpc
[311.679884] Dynamic subtest slpc: SUCCESS (14.227s)
[311.688714] Starting dynamic subtest: guc
[315.741587] Dynamic subtest guc: SUCCESS (4.060s)
[315.749434] Starting dynamic subtest: guc_multi_lrc
[320.189797] Dynamic subtest guc_multi_lrc: SUCCESS (4.445s)
[320.198072] Starting dynamic subtest: guc_hang
[325.120041] Dynamic subtest guc_hang: SUCCESS (4.928s)
[325.127864] Starting dynamic subtest: late_gt_pm
[329.613477] Dynamic subtest late_gt_pm: SUCCESS (4.491s)
[329.615222] Subtest live: SUCCESS (245.534s)
[329.633822] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[329.635540] [016/133] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[331.240389] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[335.609751] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.369s)
[336.771446] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[336.773589] [017/133] (684s left) gem_userptr_blits (readonly-unsync)
[336.844879] Subtest readonly-unsync: SKIP (0.000s)
[336.997070] [018/133] (684s left) drm_buddy (drm_buddy)
[337.031245] Starting subtest: drm_buddy
[337.033057] Subtest drm_buddy: SKIP (0.001s)
[337.092998] [019/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[337.191333] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[337.192983] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[337.322312] [020/133] (684s left) fbdev (read)
[337.364584] Starting subtest: read
[337.907707] Subtest read: SUCCESS (0.532s)
[337.967408] [021/133] (683s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[338.060344] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[338.061944] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[338.194308] [022/133] (683s left) kms_vblank (ts-continuation-suspend)
[338.280845] Starting subtest: ts-continuation-suspend
[338.281858] Starting dynamic subtest: pipe-A-eDP-1
[355.033711] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.798s)
[355.047715] Starting dynamic subtest: pipe-D-eDP-1
[373.058520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s)
[373.059346] Subtest ts-continuation-suspend: SUCCESS (5.396s)
[378.910517] [023/133] (647s left) kms_cursor_crc (cursor-random-64x64)
[379.090083] Starting subtest: cursor-random-64x64
[379.093564] Starting dynamic subtest: pipe-A-eDP-1
[382.331391] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.349s)
[382.359828] Starting dynamic subtest: pipe-D-eDP-1
[386.259585] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[386.260473] Subtest cursor-random-64x64: SUCCESS (7.365s)
[387.103517] [024/133] (639s left) gem_ctx_engines (independent)
[387.166167] Starting subtest: independent
[387.167106] Starting dynamic subtest: rcs0
[387.312000] Dynamic subtest rcs0: SUCCESS (0.138s)
[387.320740] Starting dynamic subtest: bcs0
[387.413925] Dynamic subtest bcs0: SUCCESS (0.111s)
[387.421663] Starting dynamic subtest: vcs0
[387.539649] Dynamic subtest vcs0: SUCCESS (0.118s)
[387.548301] Starting dynamic subtest: vcs1
[387.667092] Dynamic subtest vcs1: SUCCESS (0.127s)
[387.676782] Starting dynamic subtest: vecs0
[387.799067] Dynamic subtest vecs0: SUCCESS (0.134s)
[387.808483] Starting dynamic subtest: ccs0
[387.926901] Dynamic subtest ccs0: SUCCESS (0.129s)
[387.940153] Starting dynamic subtest: all-engines
[388.295435] Dynamic subtest all-engines: SUCCESS (0.373s)
[388.296285] Subtest independent: SUCCESS (1.137s)
[389.421599] [025/133] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[389.515471] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[396.237330] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.771s)
[396.366750] [026/133] (630s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[396.467569] Starting subtest: fbc-modesetfrombusy
[400.315522] Subtest fbc-modesetfrombusy: SUCCESS (3.862s)
[401.561336] [027/133] (625s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[401.620763] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[401.726822] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.105s)
[401.811770] [028/133] (625s left) kms_cursor_edge_walk (256x256-top-edge)
[401.915617] Starting subtest: 256x256-top-edge
[401.916426] Starting dynamic subtest: pipe-A-eDP-1
[405.331939] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.422s)
[405.339265] Starting dynamic subtest: pipe-D-eDP-1
[408.449346] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[408.450265] Subtest 256x256-top-edge: SUCCESS (6.542s)
[409.281746] [029/133] (617s left) kms_vrr (seamless-rr-switch-virtual)
[409.382795] Starting subtest: seamless-rr-switch-virtual
[409.385300] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[409.460425] [030/133] (617s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[409.526094] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[409.527731] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[409.723016] [031/133] (617s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[409.828157] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[409.829720] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[409.971844] [032/133] (617s left) kms_big_fb (linear-32bpp-rotate-270)
[410.073376] Starting subtest: linear-32bpp-rotate-270
[410.092990] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[410.234862] [033/133] (616s left) kms_getfb (getfb2-handle-protection)
[410.338040] Starting subtest: getfb2-handle-protection
[410.366565] Subtest getfb2-handle-protection: SUCCESS (0.030s)
[410.536414] [034/133] (616s left) kms_pm_rpm (system-suspend-modeset)
[412.413096] Starting subtest: system-suspend-modeset
[433.183150] Subtest system-suspend-modeset: SUCCESS (4.903s)
[436.633256] [035/133] (593s left) syncobj_timeline (invalid-signal-illegal-handle)
[436.694773] Starting subtest: invalid-signal-illegal-handle
[436.695555] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[436.814284] [036/133] (593s left) kms_chamelium_hpd (common-hpd-after-suspend)
[437.190608] Subtest common-hpd-after-suspend: SKIP (0.000s)
[438.016059] [037/133] (592s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[438.100760] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[438.102313] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[439.240066] [038/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[439.338691] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[439.340346] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[439.470759] [039/133] (590s left) gem_exec_balancer (smoke)
[439.528985] Starting subtest: smoke
[461.980875] Subtest smoke: SUCCESS (22.625s)
[463.017690] [040/133] (567s left) kms_setmode (basic)
[463.076506] Starting subtest: basic
[463.414567] Starting dynamic subtest: pipe-A-eDP-1
[466.935333] Dynamic subtest pipe-A-eDP-1: FAIL (3.477s)
[467.226002] Starting dynamic subtest: pipe-B-eDP-1
[470.707266] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.480s)
[471.017382] Subtest basic: FAIL (7.947s)
[471.827514] [041/133] (558s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[471.928471] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[471.930077] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[472.057152] [042/133] (558s left) kms_color (deep-color)
[472.148731] Starting subtest: deep-color
[473.179742] Starting dynamic subtest: pipe-A-eDP-1-gamma
[473.913435] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.733s)
[473.920999] Starting dynamic subtest: pipe-A-eDP-1-degamma
[475.367071] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.452s)
[475.374464] Starting dynamic subtest: pipe-A-eDP-1-ctm
[476.836749] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.468s)
[477.591920] Starting dynamic subtest: pipe-B-eDP-1-gamma
[478.308093] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.723s)
[478.315683] Starting dynamic subtest: pipe-B-eDP-1-degamma
[479.768210] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.460s)
[479.775999] Starting dynamic subtest: pipe-B-eDP-1-ctm
[481.203786] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.435s)
[481.974442] Starting dynamic subtest: pipe-C-eDP-1-gamma
[482.658204] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[482.665909] Starting dynamic subtest: pipe-C-eDP-1-degamma
[484.025923] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.366s)
[484.033858] Starting dynamic subtest: pipe-C-eDP-1-ctm
[485.448780] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.421s)
[486.281225] Starting dynamic subtest: pipe-D-eDP-1-gamma
[486.976043] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s)
[486.983545] Starting dynamic subtest: pipe-D-eDP-1-degamma
[488.438363] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.462s)
[488.446009] Starting dynamic subtest: pipe-D-eDP-1-ctm
[489.868608] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.430s)
[489.869718] Subtest deep-color: SUCCESS (17.722s)
[490.735727] [043/133] (539s left) gem_lmem_swapping (parallel-random-verify)
[490.776988] Subtest parallel-random-verify: SKIP (0.000s)
[490.809731] [044/133] (539s left) kms_flip (dpms-vs-vblank-race)
[490.902751] Starting subtest: dpms-vs-vblank-race
[490.903634] Starting dynamic subtest: A-eDP1
[494.816863] Dynamic subtest A-eDP1: SUCCESS (3.914s)
[494.824644] Starting dynamic subtest: B-eDP1
[499.425253] Dynamic subtest B-eDP1: SUCCESS (4.607s)
[499.434023] Starting dynamic subtest: C-eDP1
[504.032888] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[504.040691] Starting dynamic subtest: D-eDP1
[508.648432] Dynamic subtest D-eDP1: SUCCESS (4.614s)
[508.650418] Subtest dpms-vs-vblank-race: SUCCESS (17.748s)
[509.540115] [045/133] (521s left) kms_chamelium_color (degamma)
[509.639088] Subtest degamma: SKIP (0.000s)
[509.680049] [046/133] (520s left) api_intel_bb (add-remove-objects)
[509.741656] Starting subtest: add-remove-objects
[509.747526] Subtest add-remove-objects: SUCCESS (0.007s)
[509.896527] [047/133] (520s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[510.015595] Starting subtest: cursor-vs-flip-atomic
[539.394018] Subtest cursor-vs-flip-atomic: SUCCESS (29.382s)
[540.271256] [048/133] (490s left) gem_userptr_blits (readonly-pwrite-unsync)
[540.336494] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[540.470745] [049/133] (490s left) gem_exec_schedule (wide)
[540.654249] Starting subtest: wide
[540.655369] Starting dynamic subtest: rcs0
[550.911179] Dynamic subtest rcs0: SUCCESS (10.221s)
[550.920598] Starting dynamic subtest: vcs0
[561.331126] Dynamic subtest vcs0: SUCCESS (10.456s)
[561.343692] Starting dynamic subtest: vcs1
[571.640758] Dynamic subtest vcs1: SUCCESS (10.311s)
[571.649272] Starting dynamic subtest: vecs0
[583.335300] Dynamic subtest vecs0: SUCCESS (11.697s)
[583.345472] Starting dynamic subtest: ccs0
[597.691908] Dynamic subtest ccs0: SUCCESS (14.323s)
[597.695305] Subtest wide: SUCCESS (57.016s)
[599.344698] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[599.346444] [050/133] (431s left) kms_force_connector_basic (force-load-detect)
[599.418062] Starting subtest: force-load-detect
[599.420015] Subtest force-load-detect: SKIP (0.000s)
[599.549981] [051/133] (431s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[599.601694] Starting subtest: multi-wait-all-for-submit-submitted
[599.710076] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[599.791236] [052/133] (431s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[599.923403] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[617.222602] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.303s)
[618.034643] [053/133] (412s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[618.142551] Starting subtest: yf-tiled-8bpp-rotate-270
[618.144306] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[618.244230] [054/133] (412s left) core_auth (getclient-simple)
[618.277871] Starting subtest: getclient-simple
[618.292583] Subtest getclient-simple: SUCCESS (0.014s)
[618.410055] [055/133] (412s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[618.507426] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[618.509215] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[618.641571] [056/133] (412s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[618.744088] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[618.746169] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[618.861301] [057/133] (412s left) gem_exec_reloc (basic-wc)
[618.915989] Subtest basic-wc: SKIP (0.000s)
[618.999891] [058/133] (412s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[619.095527] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[619.097298] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[619.194164] [059/133] (411s left) syncobj_basic (illegal-fd-to-handle)
[619.250699] Starting subtest: illegal-fd-to-handle
[619.251644] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[619.367473] [060/133] (411s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[619.460760] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[619.462465] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[619.544262] [061/133] (411s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[619.630424] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[619.632039] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[619.760766] [062/133] (411s left) kms_flip (wf_vblank-ts-check)
[619.856976] Starting subtest: wf_vblank-ts-check
[619.857908] Starting dynamic subtest: A-eDP1
[628.795246] Dynamic subtest A-eDP1: SUCCESS (8.910s)
[628.805690] Starting dynamic subtest: B-eDP1
[637.738913] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[637.749226] Starting dynamic subtest: C-eDP1
[646.680134] Dynamic subtest C-eDP1: SUCCESS (8.921s)
[646.690715] Starting dynamic subtest: D-eDP1
[655.590552] Dynamic subtest D-eDP1: SUCCESS (8.937s)
[655.592086] Subtest wf_vblank-ts-check: SUCCESS (35.712s)
[656.821486] [063/133] (374s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[656.912549] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[656.913637] Starting dynamic subtest: pipe-A-eDP-1
[656.922248] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[656.932954] Starting dynamic subtest: pipe-B-eDP-1
[656.941328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[656.948976] Starting dynamic subtest: pipe-C-eDP-1
[656.956708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[656.964075] Starting dynamic subtest: pipe-D-eDP-1
[656.972441] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[656.974153] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.005s)
[659.181022] [064/133] (372s left) kms_psr (fbc-pr-cursor-blt)
[659.284934] Starting subtest: fbc-pr-cursor-blt
[659.286505] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[659.363929] [065/133] (371s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[659.462199] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[659.463196] Starting dynamic subtest: pipe-A
[659.480612] Dynamic subtest pipe-A: SKIP (0.017s)
[659.488372] Starting dynamic subtest: pipe-B
[659.511050] Dynamic subtest pipe-B: SKIP (0.030s)
[659.518876] Starting dynamic subtest: pipe-C
[659.540447] Dynamic subtest pipe-C: SKIP (0.029s)
[659.547900] Starting dynamic subtest: pipe-D
[659.570610] Dynamic subtest pipe-D: SKIP (0.030s)
[659.572162] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.108s)
[659.690725] [066/133] (371s left) sw_sync (alloc_timeline)
[659.718597] Starting subtest: alloc_timeline
[659.719688] Subtest alloc_timeline: SUCCESS (0.000s)
[659.774720] [067/133] (371s left) kms_selftest (drm_format_helper)
[659.816460] Starting subtest: drm_format_helper
[659.870975] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[660.028269] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.151s)
[660.037817] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[660.184643] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.155s)
[660.192113] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[660.339192] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.154s)
[660.347300] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[660.481238] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.147s)
[660.490177] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[660.617740] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.128s)
[660.627256] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[660.734638] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.123s)
[660.742689] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[660.872389] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.130s)
[660.879734] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[661.010281] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.137s)
[661.019562] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[661.149233] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.138s)
[661.158197] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[661.302250] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.151s)
[661.311476] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[661.436399] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.134s)
[661.443705] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[661.585170] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.147s)
[661.593374] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[661.722560] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.137s)
[661.729928] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[661.880401] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.156s)
[661.889841] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[662.018019] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.143s)
[662.026528] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[662.173423] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.148s)
[662.181113] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[662.319856] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.150s)
[662.320668] Subtest drm_format_helper: SUCCESS (2.498s)
[662.533216] [068/133] (368s left) gem_userptr_blits (sync-unmap-cycles)
[662.604599] Starting subtest: sync-unmap-cycles
[667.985641] Subtest sync-unmap-cycles: SUCCESS (5.379s)
[668.150213] [069/133] (363s left) perf_pmu (rc6)
[668.186825] Starting subtest: rc6
[668.187758] Starting dynamic subtest: gt0
[674.586429] Dynamic subtest gt0: SUCCESS (6.387s)
[674.595928] Starting dynamic subtest: runtime-pm-gt0
[682.304304] Dynamic subtest runtime-pm-gt0: SUCCESS (7.715s)
[682.313864] Starting dynamic subtest: runtime-pm-long-gt0
[694.798060] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.493s)
[694.809084] Starting dynamic subtest: other-idle-gt0
[701.140610] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[701.152003] Starting dynamic subtest: gt1
[707.481334] Dynamic subtest gt1: SUCCESS (6.339s)
[707.489302] Starting dynamic subtest: runtime-pm-gt1
[714.904666] Dynamic subtest runtime-pm-gt1: SUCCESS (7.421s)
[714.915178] Starting dynamic subtest: runtime-pm-long-gt1
[727.383642] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.477s)
[727.395003] Starting dynamic subtest: other-idle-gt1
[733.726406] Dynamic subtest other-idle-gt1: SUCCESS (6.342s)
[733.727904] Subtest rc6: SUCCESS (65.530s)
[734.324449] [070/133] (297s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[734.430314] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[734.442218] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[734.532472] [071/133] (296s left) gem_exec_reloc (basic-cpu)
[734.592744] Subtest basic-cpu: SKIP (0.000s)
[734.679023] [072/133] (296s left) kms_psr (psr2-primary-mmap-cpu)
[734.773040] Starting subtest: psr2-primary-mmap-cpu
[734.773914] Starting dynamic subtest: eDP-1
[736.441364] Dynamic subtest eDP-1: SUCCESS (1.668s)
[736.442196] Subtest psr2-primary-mmap-cpu: SUCCESS (1.669s)
[737.297552] [073/133] (294s left) sriov_basic (enable-vfs-autoprobe-on)
[737.364240] Starting subtest: enable-vfs-autoprobe-on
[737.365182] Starting dynamic subtest: numvfs-1
[737.393317] Dynamic subtest numvfs-1: FAIL (0.005s)
[737.402777] Starting dynamic subtest: numvfs-2
[737.430756] Dynamic subtest numvfs-2: FAIL (0.004s)
[737.438670] Starting dynamic subtest: numvfs-3
[737.464758] Dynamic subtest numvfs-3: FAIL (0.003s)
[737.472389] Starting dynamic subtest: numvfs-4
[737.496237] Dynamic subtest numvfs-4: FAIL (0.003s)
[737.504180] Starting dynamic subtest: numvfs-5
[737.529144] Dynamic subtest numvfs-5: FAIL (0.004s)
[737.536894] Starting dynamic subtest: numvfs-6
[737.562050] Dynamic subtest numvfs-6: FAIL (0.003s)
[737.570043] Starting dynamic subtest: numvfs-7
[737.598016] Dynamic subtest numvfs-7: FAIL (0.004s)
[737.606319] Starting dynamic subtest: numvfs-random
[737.631965] Dynamic subtest numvfs-random: FAIL (0.004s)
[737.639527] Starting dynamic subtest: numvfs-all
[737.664827] Dynamic subtest numvfs-all: FAIL (0.004s)
[737.665690] Subtest enable-vfs-autoprobe-on: FAIL (0.040s)
[737.694744] [074/133] (293s left) i915_pm_freq_api (freq-reset)
[737.758210] Starting subtest: freq-reset
[737.759244] Starting dynamic subtest: gt0
[737.947160] Dynamic subtest gt0: SUCCESS (0.188s)
[737.955985] Starting dynamic subtest: gt1
[738.123281] Dynamic subtest gt1: SUCCESS (0.167s)
[738.124438] Subtest freq-reset: SUCCESS (0.356s)
[738.160463] [075/133] (293s left) gem_exec_nop (basic-parallel)
[738.238979] Starting subtest: basic-parallel
[754.147094] Subtest basic-parallel: SUCCESS (15.910s)
[754.374051] [076/133] (277s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[754.471687] Starting subtest: primary-y-tiled-reflect-x-180
[754.542191] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[754.617623] [077/133] (277s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[754.714142] Starting subtest: fbc-psr2-cursor-plane-update-sf
[754.714973] Starting dynamic subtest: pipe-A-eDP-1
[754.783113] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[754.792888] Starting dynamic subtest: pipe-B-eDP-1
[755.888006] Dynamic subtest pipe-B-eDP-1: SKIP (1.103s)
[755.889694] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.183s)
[757.048529] [078/133] (274s left) syncobj_timeline (reset-multiple-signaled)
[757.113874] Starting subtest: reset-multiple-signaled
[757.114945] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[757.199928] [079/133] (274s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[757.295755] Starting subtest: 4-tiled-8bpp-rotate-270
[757.318521] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[757.427907] [080/133] (274s left) gem_spin_batch (resubmit-new)
[757.489906] Starting subtest: resubmit-new
[757.491049] Starting dynamic subtest: rcs0
[757.496153] Dynamic subtest rcs0: SUCCESS (0.008s)
[757.506216] Starting dynamic subtest: bcs0
[757.507268] Dynamic subtest bcs0: SUCCESS (0.004s)
[757.518423] Starting dynamic subtest: vcs0
[757.519353] Dynamic subtest vcs0: SUCCESS (0.004s)
[757.527274] Starting dynamic subtest: vcs1
[757.528180] Dynamic subtest vcs1: SUCCESS (0.004s)
[757.536440] Starting dynamic subtest: vecs0
[757.537376] Dynamic subtest vecs0: SUCCESS (0.004s)
[757.545357] Starting dynamic subtest: ccs0
[757.546179] Dynamic subtest ccs0: SUCCESS (0.004s)
[757.546985] Subtest resubmit-new: SUCCESS (0.033s)
[759.147977] [081/133] (272s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[759.256035] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[760.290147] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.034s)
[760.384603] [082/133] (271s left) kms_pm_dc (dc3co-vpb-simulation)
[761.479954] Starting subtest: dc3co-vpb-simulation
[770.119857] Subtest dc3co-vpb-simulation: SKIP (8.591s)
[770.193467] [083/133] (261s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[770.297932] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[770.299640] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[770.391940] [084/133] (261s left) perf_pmu (init-busy)
[770.432789] Starting subtest: init-busy
[770.433714] Starting dynamic subtest: rcs0
[770.434683] Dynamic subtest rcs0: SUCCESS (0.001s)
[770.443453] Starting dynamic subtest: bcs0
[770.444467] Dynamic subtest bcs0: SUCCESS (0.000s)
[770.452837] Starting dynamic subtest: vcs0
[770.453813] Dynamic subtest vcs0: SUCCESS (0.001s)
[770.461889] Starting dynamic subtest: vcs1
[770.462869] Dynamic subtest vcs1: SUCCESS (0.000s)
[770.471068] Starting dynamic subtest: vecs0
[770.472092] Dynamic subtest vecs0: SUCCESS (0.000s)
[770.480396] Starting dynamic subtest: ccs0
[770.481414] Dynamic subtest ccs0: SUCCESS (0.000s)
[770.482450] Subtest init-busy: SUCCESS (0.007s)
[770.534561] [085/133] (261s left) gem_sync (basic-all)
[770.600675] Starting subtest: basic-all
[774.179481] Subtest basic-all: SUCCESS (3.570s)
[774.325531] [086/133] (257s left) syncobj_wait (single-wait-for-submit-submitted)
[774.385390] Starting subtest: single-wait-for-submit-submitted
[774.494415] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[774.542587] [087/133] (257s left) gem_exec_reloc (basic-active)
[774.597959] Subtest basic-active: SKIP (0.000s)
[774.683637] [088/133] (257s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[774.774917] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[774.775739] Starting dynamic subtest: pipe-A
[774.794369] Dynamic subtest pipe-A: SKIP (0.018s)
[774.803098] Starting dynamic subtest: pipe-B
[774.825514] Dynamic subtest pipe-B: SKIP (0.031s)
[774.834194] Starting dynamic subtest: pipe-C
[774.857118] Dynamic subtest pipe-C: SKIP (0.030s)
[774.865344] Starting dynamic subtest: pipe-D
[774.888137] Dynamic subtest pipe-D: SKIP (0.031s)
[774.889877] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.113s)
[774.977044] [089/133] (257s left) gem_ctx_isolation (nonpriv)
[775.043984] Starting subtest: nonpriv
[775.045077] Starting dynamic subtest: rcs0
[775.282616] Dynamic subtest rcs0: SUCCESS (0.238s)
[775.294837] Starting dynamic subtest: bcs0
[775.554742] Dynamic subtest bcs0: SUCCESS (0.272s)
[775.564204] Starting dynamic subtest: vcs0
[775.818793] Dynamic subtest vcs0: SUCCESS (0.263s)
[775.829972] Starting dynamic subtest: vcs1
[777.449409] Dynamic subtest vcs1: SUCCESS (1.630s)
[777.460417] Starting dynamic subtest: vecs0
[779.436775] Dynamic subtest vecs0: SUCCESS (1.986s)
[779.448111] Starting dynamic subtest: ccs0
[781.449782] Dynamic subtest ccs0: SUCCESS (2.011s)
[781.450816] Subtest nonpriv: SUCCESS (6.407s)
[781.671465] [090/133] (250s left) kms_async_flips (crc)
[781.787197] Starting subtest: crc
[782.162440] Starting dynamic subtest: pipe-A-eDP-1
[785.069511] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.907s)
[785.459734] Starting dynamic subtest: pipe-B-eDP-1
[788.331673] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s)
[788.704526] Starting dynamic subtest: pipe-C-eDP-1
[791.635506] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.939s)
[791.997605] Starting dynamic subtest: pipe-D-eDP-1
[794.851690] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.862s)
[794.852552] Subtest crc: SUCCESS (13.066s)
[796.003007] [091/133] (236s left) i915_pm_rps (engine-order)
[796.080418] Starting subtest: engine-order
[802.310170] Subtest engine-order: SUCCESS (6.225s)
[802.421040] [092/133] (229s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[802.525938] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[807.127347] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.603s)
[808.208183] [093/133] (224s left) gem_exec_fence (parallel)
[808.386161] Starting subtest: parallel
[808.387060] Starting dynamic subtest: rcs0
[810.531948] Dynamic subtest rcs0: SUCCESS (2.150s)
[810.541987] Starting dynamic subtest: bcs0
[812.683370] Dynamic subtest bcs0: SUCCESS (2.151s)
[812.693565] Starting dynamic subtest: vcs0
[814.832715] Dynamic subtest vcs0: SUCCESS (2.149s)
[814.841510] Starting dynamic subtest: vcs1
[816.983269] Dynamic subtest vcs1: SUCCESS (2.150s)
[816.992819] Starting dynamic subtest: vecs0
[819.134112] Dynamic subtest vecs0: SUCCESS (2.150s)
[819.144729] Starting dynamic subtest: ccs0
[821.287033] Dynamic subtest ccs0: SUCCESS (2.152s)
[821.288415] Subtest parallel: SUCCESS (12.907s)
[822.250579] [094/133] (210s left) syncobj_timeline (wait-all-for-submit-complex)
[822.314190] Starting subtest: wait-all-for-submit-complex
[822.537100] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[822.578269] [095/133] (209s left) kms_lease (lease-invalid-connector)
[822.676600] Starting subtest: lease-invalid-connector
[822.677553] Starting dynamic subtest: pipe-A-eDP-1
[822.678473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[822.687766] Starting dynamic subtest: pipe-B-eDP-1
[822.688684] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[822.697064] Starting dynamic subtest: pipe-C-eDP-1
[822.697890] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[822.705852] Starting dynamic subtest: pipe-D-eDP-1
[822.706661] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[822.707498] Subtest lease-invalid-connector: SUCCESS (0.004s)
[822.736015] [096/133] (209s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[822.806455] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[822.808298] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[822.961953] [097/133] (209s left) kms_psr (fbc-psr2-sprite-plane-move)
[823.046937] Starting subtest: fbc-psr2-sprite-plane-move
[823.047766] Starting dynamic subtest: eDP-1
[823.049462] Dynamic subtest eDP-1: SKIP (0.000s)
[823.051296] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[823.090395] [098/133] (209s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[823.178736] Starting subtest: y-tiled-64bpp-rotate-270
[823.180577] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[823.261270] [099/133] (209s left) gem_exec_schedule (semaphore-noskip)
[823.331280] Starting subtest: semaphore-noskip
[823.754319] Subtest semaphore-noskip: SUCCESS (0.414s)
[824.079957] [100/133] (208s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[824.170346] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[824.172176] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[824.235179] [101/133] (208s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[824.340918] Starting subtest: flip-vs-cursor-busy-crc-atomic
[825.162394] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.820s)
[825.940141] [102/133] (206s left) gem_exec_flush (basic-uc-pro-default)
[826.002385] Starting subtest: basic-uc-pro-default
[831.460683] Subtest basic-uc-pro-default: SUCCESS (5.459s)
[831.617981] [103/133] (200s left) gem_exec_balancer (bonded-dual)
[831.681274] Starting subtest: bonded-dual
[831.683149] Subtest bonded-dual: SKIP (0.000s)
[831.980477] [104/133] (200s left) kms_psr (fbc-pr-sprite-blt)
[832.084916] Starting subtest: fbc-pr-sprite-blt
[832.086606] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[832.127699] [105/133] (200s left) gem_gpgpu_fill (offset-16x16)
[832.189599] Starting subtest: offset-16x16
[832.198287] Subtest offset-16x16: SUCCESS (0.008s)
[832.314523] [106/133] (200s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[832.405168] Starting subtest: plane-primary-overlay-mutable-zpos
[835.802441] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.397s)
[836.976271] [107/133] (195s left) gem_pread (snoop)
[837.038212] Subtest snoop: SKIP (0.000s)
[837.109946] [108/133] (195s left) gem_mmap_gtt (hang-busy)
[837.156342] Subtest hang-busy: SKIP (0.000s)
[837.228507] [109/133] (195s left) gem_mmap_wc (fault-concurrent)
[837.278484] Subtest fault-concurrent: SKIP (0.000s)
[837.351294] [110/133] (195s left) kms_content_protection (suspend-resume)
[837.488826] Starting subtest: suspend-resume
[837.490623] Subtest suspend-resume: SKIP (0.000s)
[837.627701] [111/133] (195s left) gem_exec_alignment (forked)
[837.690447] Starting subtest: forked
[877.264731] Subtest forked: SUCCESS (39.531s)
[877.303010] [112/133] (155s left) syncobj_wait (multi-wait-all-submitted-signaled)
[877.402327] Starting subtest: multi-wait-all-submitted-signaled
[877.509766] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[877.570009] [113/133] (155s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[877.631450] Starting subtest: invalid-bsd2-flag-on-blt
[877.632426] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[877.706701] [114/133] (155s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[877.805638] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[877.806534] Starting dynamic subtest: pipe-A-default-mode
[878.945324] Dynamic subtest pipe-A-default-mode: SKIP (1.137s)
[878.947102] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.139s)
[879.086440] [115/133] (153s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[879.137722] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[879.247641] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.107s)
[879.293064] [116/133] (153s left) gem_madvise (dontneed-after-mmap)
[879.322772] Starting subtest: dontneed-after-mmap
[879.341887] Subtest dontneed-after-mmap: SUCCESS (0.019s)
[879.433031] [117/133] (153s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[879.534277] Starting subtest: dsc-fractional-bpp-with-bpc
[879.546750] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[879.576845] [118/133] (153s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[879.674282] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[883.800943] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.127s)
[884.896968] [119/133] (148s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[885.013127] Starting subtest: bad-rotation-90-yf-tiled-ccs
[885.013948] Starting dynamic subtest: pipe-A-eDP-1
[885.022243] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[885.034061] Starting dynamic subtest: pipe-B-eDP-1
[885.043040] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[885.053454] Starting dynamic subtest: pipe-C-eDP-1
[885.061713] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[885.070102] Starting dynamic subtest: pipe-D-eDP-1
[885.078537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[885.080198] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[887.250421] [120/133] (145s left) gem_mmap_offset (pf-nonblock)
[887.298386] Starting subtest: pf-nonblock
[887.305493] Subtest pf-nonblock: SUCCESS (0.007s)
[887.408986] [121/133] (145s left) kms_cursor_crc (cursor-offscreen-512x170)
[887.696704] Starting subtest: cursor-offscreen-512x170
[887.698307] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[887.823498] [122/133] (145s left) sw_sync (sync_multi_timeline_wait)
[887.864043] Starting subtest: sync_multi_timeline_wait
[887.865046] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[887.908242] [123/133] (145s left) gem_ctx_persistence (processes)
[887.963942] Starting subtest: processes
[889.128916] Subtest processes: SUCCESS (1.165s)
[889.181987] [124/133] (144s left) kms_plane_alpha_blend (coverage-7efc)
[889.280245] Starting subtest: coverage-7efc
[889.573174] Starting dynamic subtest: pipe-A-eDP-1
[890.160408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.587s)
[890.189460] Starting dynamic subtest: pipe-D-eDP-1
[891.487419] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[891.488339] Subtest coverage-7efc: SUCCESS (2.209s)
[892.311047] [125/133] (141s left) i915_drm_fdinfo (memory-info-idle)
[892.348575] Starting subtest: memory-info-idle
[892.349546] Starting dynamic subtest: smem0
[892.403944] Dynamic subtest smem0: SUCCESS (0.055s)
[892.405562] Subtest memory-info-idle: SUCCESS (0.055s)
[892.448617] [126/133] (140s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[892.541899] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[892.542843] Starting dynamic subtest: pipe-A-eDP-1
[892.641730] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[892.653238] Starting dynamic subtest: pipe-B-eDP-1
[893.810019] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[893.812061] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.269s)
[894.977864] [127/133] (138s left) vgem_slow (nohang)
[895.018309] Starting subtest: nohang
[905.573265] Subtest nohang: SUCCESS (10.510s)
[905.606137] [128/133] (127s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[905.729454] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[905.731235] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[905.779974] [129/133] (127s left) syncobj_wait (wait-all-delayed-signal)
[905.833360] Starting subtest: wait-all-delayed-signal
[905.936465] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[905.987451] [130/133] (127s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[906.077943] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[906.079757] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[906.121833] [131/133] (127s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[906.205017] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[906.205892] Starting dynamic subtest: pipe-A-eDP-1
[906.214381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[906.223691] Starting dynamic subtest: pipe-B-eDP-1
[906.232397] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[906.241558] Starting dynamic subtest: pipe-C-eDP-1
[906.249941] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[906.258703] Starting dynamic subtest: pipe-D-eDP-1
[906.267088] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[906.268607] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[908.358924] [132/133] (125s left) kms_getfb (getfb-handle-closed)
[908.455004] Starting subtest: getfb-handle-closed
[908.455924] Subtest getfb-handle-closed: SUCCESS (0.000s)
[908.567349] [133/133] (125s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[908.666098] Starting subtest: extended-pageflip-modeset-hang-oldfb
[908.667005] Starting dynamic subtest: pipe-A
[916.579374] Dynamic subtest pipe-A: SUCCESS (7.914s)
[916.589483] Starting dynamic subtest: pipe-D
[925.183403] Dynamic subtest pipe-D: SUCCESS (8.603s)
[925.186121] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.521s)
[926.034085] 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.