[57.117501] Initializing watchdogs
[57.117642]   /dev/watchdog0
[57.133151] [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]
[57.137813] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.140030] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.143657] [001/133] (960s left) kms_addfb_basic (basic)
[57.218948] Starting subtest: basic
[57.221174] Subtest basic: SUCCESS (0.000s)
[57.399526] [002/133] (960s left) gem_userptr_blits (unsync-unmap-after-close)
[57.478487] Subtest unsync-unmap-after-close: SKIP (0.000s)
[57.611470] [003/133] (960s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[57.676557] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[57.743335] [004/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[57.843694] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[57.847928] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[57.958952] [005/133] (959s left) kms_invalid_mode (bad-hsync-start)
[58.058904] Starting subtest: bad-hsync-start
[58.061127] Starting dynamic subtest: pipe-A-eDP-1
[58.339933] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[58.347947] Starting dynamic subtest: pipe-B-eDP-1
[58.350037] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[58.356365] Starting dynamic subtest: pipe-C-eDP-1
[58.358291] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.365110] Starting dynamic subtest: pipe-D-eDP-1
[58.367274] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.369510] Subtest bad-hsync-start: SUCCESS (0.292s)
[59.167150] [006/133] (958s left) gem_exec_schedule (implicit-read-write)
[59.243627] Starting subtest: implicit-read-write
[59.245825] Starting dynamic subtest: rcs0
[59.345050] Dynamic subtest rcs0: SUCCESS (0.107s)
[59.356171] Starting dynamic subtest: vcs0
[59.422354] Dynamic subtest vcs0: SUCCESS (0.077s)
[59.432759] Starting dynamic subtest: vcs1
[59.501470] Dynamic subtest vcs1: SUCCESS (0.078s)
[59.513493] Starting dynamic subtest: vecs0
[59.580533] Dynamic subtest vecs0: SUCCESS (0.080s)
[59.587414] Starting dynamic subtest: ccs0
[59.666023] Dynamic subtest ccs0: SUCCESS (0.084s)
[59.668928] Subtest implicit-read-write: SUCCESS (0.429s)
[60.997497] [007/133] (956s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[61.095553] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[61.097692] Starting dynamic subtest: pipe-A-eDP-1
[61.122193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.133436] Starting dynamic subtest: pipe-B-eDP-1
[61.158148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.167237] Starting dynamic subtest: pipe-C-eDP-1
[61.193064] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.201311] Starting dynamic subtest: pipe-D-eDP-1
[61.226023] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.230596] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[63.352175] [008/133] (954s left) syncobj_timeline (wait-for-submit-snapshot)
[63.411747] Starting subtest: wait-for-submit-snapshot
[63.492789] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[63.581309] [009/133] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[63.673362] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[70.994758] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.324s)
[71.116739] [010/133] (946s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[71.217354] Starting subtest: psr-dirtyfb-ioctl
[71.219690] Starting dynamic subtest: A-eDP-1
[75.181873] Dynamic subtest A-eDP-1: SUCCESS (3.964s)
[75.183793] Subtest psr-dirtyfb-ioctl: SUCCESS (3.965s)
[75.999672] [011/133] (942s left) gen7_exec_parse (basic-offset)
[76.069376] Subtest basic-offset: SKIP (0.000s)
[76.136593] [012/133] (941s left) kms_psr (pr-cursor-render)
[76.224603] Starting subtest: pr-cursor-render
[76.228710] Subtest pr-cursor-render: SKIP (0.000s)
[76.320786] [013/133] (941s left) kms_psr (psr-primary-render)
[76.415019] Starting subtest: psr-primary-render
[76.417497] Starting dynamic subtest: eDP-1
[78.181640] Dynamic subtest eDP-1: SUCCESS (1.763s)
[78.183993] Subtest psr-primary-render: SUCCESS (1.764s)
[79.052691] [014/133] (939s left) gem_vm_create (isolation)
[79.125764] Starting subtest: isolation
[79.131806] Subtest isolation: SUCCESS (0.008s)
[79.284178] [015/133] (938s left) i915_selftest (live)
[81.244951] Starting subtest: live
[81.247194] Starting dynamic subtest: sanitycheck
[85.649054] Dynamic subtest sanitycheck: SUCCESS (4.405s)
[85.656245] Starting dynamic subtest: uncore
[90.145947] Dynamic subtest uncore: SUCCESS (4.494s)
[90.154210] Starting dynamic subtest: workarounds
[94.915452] Dynamic subtest workarounds: SUCCESS (4.767s)
[94.923650] Starting dynamic subtest: gt_engines
[99.564993] Dynamic subtest gt_engines: SUCCESS (4.647s)
[99.572948] Starting dynamic subtest: gt_timelines
[115.535473] Dynamic subtest gt_timelines: SUCCESS (15.967s)
[115.544372] Starting dynamic subtest: gt_contexts
[119.954268] Dynamic subtest gt_contexts: SUCCESS (4.418s)
[119.962976] Starting dynamic subtest: gt_lrc
[124.361760] Dynamic subtest gt_lrc: SUCCESS (4.406s)
[124.370494] Starting dynamic subtest: gt_mocs
[127.457802] Dynamic subtest gt_mocs: SUCCESS (3.092s)
[127.466032] Starting dynamic subtest: gt_pm
[134.313932] Dynamic subtest gt_pm: SUCCESS (6.858s)
[134.327283] Starting dynamic subtest: gt_heartbeat
[138.772851] Dynamic subtest gt_heartbeat: SUCCESS (4.457s)
[138.781898] Starting dynamic subtest: gt_tlb
[148.237775] Dynamic subtest gt_tlb: SUCCESS (9.463s)
[148.246279] Starting dynamic subtest: requests
[159.821726] Dynamic subtest requests: SUCCESS (11.582s)
[159.830370] Starting dynamic subtest: migrate
[167.841037] Dynamic subtest migrate: SUCCESS (8.018s)
[167.849895] Starting dynamic subtest: active
[172.233297] Dynamic subtest active: SUCCESS (4.388s)
[172.241774] Starting dynamic subtest: objects
[177.054834] Dynamic subtest objects: SUCCESS (4.823s)
[177.065585] Starting dynamic subtest: mman
[182.014086] Dynamic subtest mman: SUCCESS (4.957s)
[182.022875] Starting dynamic subtest: dmabuf
[186.478336] Dynamic subtest dmabuf: SUCCESS (4.462s)
[186.487123] Starting dynamic subtest: vma
[190.925029] Dynamic subtest vma: SUCCESS (4.445s)
[190.933235] Starting dynamic subtest: coherency
[194.752422] Dynamic subtest coherency: SUCCESS (3.825s)
[194.761230] Starting dynamic subtest: gtt
[206.702770] Dynamic subtest gtt: SUCCESS (11.949s)
[206.711485] Starting dynamic subtest: gem
[214.764210] Dynamic subtest gem: SUCCESS (8.060s)
[214.772908] Starting dynamic subtest: evict
[220.366996] Dynamic subtest evict: SUCCESS (5.601s)
[220.375704] Starting dynamic subtest: hugepages
[229.679778] Dynamic subtest hugepages: SUCCESS (9.311s)
[229.686903] Starting dynamic subtest: gem_contexts
[258.677486] Dynamic subtest gem_contexts: SUCCESS (28.995s)
[258.685503] Starting dynamic subtest: client
[263.155412] Dynamic subtest client: SUCCESS (4.476s)
[263.169709] Starting dynamic subtest: gem_migrate
[267.635852] Dynamic subtest gem_migrate: SUCCESS (4.478s)
[267.644344] Starting dynamic subtest: reset
[270.512494] Dynamic subtest reset: SUCCESS (2.875s)
[270.521059] Starting dynamic subtest: memory_region
[274.988065] Dynamic subtest memory_region: SUCCESS (4.474s)
[274.996608] Starting dynamic subtest: hangcheck
[288.630830] Dynamic subtest hangcheck: SUCCESS (13.642s)
[288.639399] Starting dynamic subtest: execlists
[291.459439] Dynamic subtest execlists: SUCCESS (2.827s)
[291.468269] Starting dynamic subtest: ring_submission
[294.333053] Dynamic subtest ring_submission: SUCCESS (2.872s)
[294.341443] Starting dynamic subtest: perf
[297.352316] Dynamic subtest perf: SUCCESS (3.017s)
[297.360488] Starting dynamic subtest: slpc
[311.582489] Dynamic subtest slpc: SUCCESS (14.229s)
[311.596422] Starting dynamic subtest: guc
[315.685819] Dynamic subtest guc: SUCCESS (4.101s)
[315.694363] Starting dynamic subtest: guc_multi_lrc
[320.186324] Dynamic subtest guc_multi_lrc: SUCCESS (4.499s)
[320.195089] Starting dynamic subtest: guc_hang
[325.195041] Dynamic subtest guc_hang: SUCCESS (5.006s)
[325.204110] Starting dynamic subtest: late_gt_pm
[329.683323] Dynamic subtest late_gt_pm: SUCCESS (4.486s)
[329.685955] Subtest live: SUCCESS (248.432s)
[329.713225] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[329.716616] [016/133] (688s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[331.347693] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[335.633244] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.289s)
[336.894981] [FACT kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)] new: kernel.kmod_is_loaded.i915: true
[336.898523] [017/133] (681s left) gem_userptr_blits (readonly-unsync)
[336.973316] Subtest readonly-unsync: SKIP (0.000s)
[337.106725] [018/133] (681s left) drm_buddy (drm_buddy)
[337.146324] Starting subtest: drm_buddy
[337.150757] Subtest drm_buddy: SKIP (0.001s)
[337.208313] [019/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[337.303301] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[337.307190] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[337.426668] [020/133] (680s left) fbdev (read)
[337.469602] Starting subtest: read
[337.999346] Subtest read: SUCCESS (0.528s)
[338.073313] [021/133] (680s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[338.174980] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[338.179114] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[338.300092] [022/133] (680s left) kms_vblank (ts-continuation-suspend)
[338.398404] Starting subtest: ts-continuation-suspend
[338.400624] Starting dynamic subtest: pipe-A-eDP-1
[355.112422] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.036s)
[355.129545] Starting dynamic subtest: pipe-D-eDP-1
[373.095212] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.576s)
[373.097418] Subtest ts-continuation-suspend: SUCCESS (4.616s)
[378.920310] [023/133] (644s left) kms_cursor_crc (cursor-random-64x64)
[379.124097] Starting subtest: cursor-random-64x64
[379.129038] Starting dynamic subtest: pipe-A-eDP-1
[382.486959] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s)
[382.513238] Starting dynamic subtest: pipe-D-eDP-1
[386.532268] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.018s)
[386.534610] Subtest cursor-random-64x64: SUCCESS (7.392s)
[387.405126] [024/133] (636s left) gem_ctx_engines (independent)
[387.477369] Starting subtest: independent
[387.479723] Starting dynamic subtest: rcs0
[387.631994] Dynamic subtest rcs0: SUCCESS (0.152s)
[387.643464] Starting dynamic subtest: bcs0
[387.758402] Dynamic subtest bcs0: SUCCESS (0.125s)
[387.768917] Starting dynamic subtest: vcs0
[387.874462] Dynamic subtest vcs0: SUCCESS (0.115s)
[387.885720] Starting dynamic subtest: vcs1
[387.994445] Dynamic subtest vcs1: SUCCESS (0.120s)
[388.003418] Starting dynamic subtest: vecs0
[388.116502] Dynamic subtest vecs0: SUCCESS (0.121s)
[388.125247] Starting dynamic subtest: ccs0
[388.233404] Dynamic subtest ccs0: SUCCESS (0.116s)
[388.243888] Starting dynamic subtest: all-engines
[388.741574] Dynamic subtest all-engines: SUCCESS (0.507s)
[388.744096] Subtest independent: SUCCESS (1.263s)
[389.204414] [025/133] (634s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[389.318768] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[396.161580] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.839s)
[396.331218] [026/133] (627s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[396.439004] Starting subtest: fbc-modesetfrombusy
[400.299771] Subtest fbc-modesetfrombusy: SUCCESS (3.863s)
[401.493614] [027/133] (622s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[401.559249] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[401.661563] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[401.749989] [028/133] (621s left) kms_cursor_edge_walk (256x256-top-edge)
[401.846378] Starting subtest: 256x256-top-edge
[401.850392] Starting dynamic subtest: pipe-A-eDP-1
[405.314688] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[405.323430] Starting dynamic subtest: pipe-D-eDP-1
[408.434848] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s)
[408.437233] Subtest 256x256-top-edge: SUCCESS (6.587s)
[409.264891] [029/133] (614s left) kms_vrr (seamless-rr-switch-virtual)
[409.368253] Starting subtest: seamless-rr-switch-virtual
[409.374484] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[409.451983] [030/133] (614s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[409.517771] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[409.521866] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[409.718646] [031/133] (614s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[409.830833] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[409.834923] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[409.927245] [032/133] (613s left) kms_big_fb (linear-32bpp-rotate-270)
[410.037208] Starting subtest: linear-32bpp-rotate-270
[410.059735] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[410.205799] [033/133] (613s left) kms_getfb (getfb2-handle-protection)
[410.299308] Starting subtest: getfb2-handle-protection
[410.324882] Subtest getfb2-handle-protection: SUCCESS (0.027s)
[410.481626] [034/133] (613s left) kms_pm_rpm (system-suspend-modeset)
[412.211132] Starting subtest: system-suspend-modeset
[432.364269] Subtest system-suspend-modeset: SUCCESS (5.047s)
[435.754569] [035/133] (591s left) syncobj_timeline (invalid-signal-illegal-handle)
[435.824724] Starting subtest: invalid-signal-illegal-handle
[435.827565] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[435.964202] [036/133] (591s left) kms_chamelium_hpd (common-hpd-after-suspend)
[436.358653] Subtest common-hpd-after-suspend: SKIP (0.000s)
[437.136858] [037/133] (589s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[437.241659] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[437.246729] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[438.403996] [038/133] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[438.512662] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[438.517590] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[438.635028] [039/133] (588s left) gem_exec_balancer (smoke)
[438.722919] Starting subtest: smoke
[461.342509] Subtest smoke: SUCCESS (22.591s)
[463.137472] [040/133] (564s left) kms_setmode (basic)
[463.207815] Starting subtest: basic
[463.528898] Starting dynamic subtest: pipe-A-eDP-1
[467.145933] Dynamic subtest pipe-A-eDP-1: FAIL (3.476s)
[467.365923] Starting dynamic subtest: pipe-B-eDP-1
[469.476793] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.114s)
[469.780411] Subtest basic: FAIL (6.568s)
[470.634503] [041/133] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[470.758842] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[470.764784] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[470.874348] [042/133] (556s left) kms_color (deep-color)
[470.979702] Starting subtest: deep-color
[472.095412] Starting dynamic subtest: pipe-A-eDP-1-gamma
[472.810418] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.717s)
[472.819207] Starting dynamic subtest: pipe-A-eDP-1-degamma
[474.297643] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.486s)
[474.307830] Starting dynamic subtest: pipe-A-eDP-1-ctm
[475.715227] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.416s)
[476.492260] Starting dynamic subtest: pipe-B-eDP-1-gamma
[477.189634] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.704s)
[477.198952] Starting dynamic subtest: pipe-B-eDP-1-degamma
[478.681845] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.493s)
[478.695495] Starting dynamic subtest: pipe-B-eDP-1-ctm
[480.111968] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.430s)
[480.880821] Starting dynamic subtest: pipe-C-eDP-1-gamma
[481.576733] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.700s)
[481.589479] Starting dynamic subtest: pipe-C-eDP-1-degamma
[483.044818] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.471s)
[483.054576] Starting dynamic subtest: pipe-C-eDP-1-ctm
[484.471268] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.425s)
[485.285709] Starting dynamic subtest: pipe-D-eDP-1-gamma
[485.976261] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.704s)
[485.988228] Starting dynamic subtest: pipe-D-eDP-1-degamma
[487.350680] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.375s)
[487.360770] Starting dynamic subtest: pipe-D-eDP-1-ctm
[488.780627] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.427s)
[488.783229] Subtest deep-color: SUCCESS (17.803s)
[489.629653] [043/133] (537s left) gem_lmem_swapping (parallel-random-verify)
[489.681341] Subtest parallel-random-verify: SKIP (0.000s)
[489.727972] [044/133] (537s left) kms_flip (dpms-vs-vblank-race)
[489.825824] Starting subtest: dpms-vs-vblank-race
[489.828578] Starting dynamic subtest: A-eDP1
[493.770526] Dynamic subtest A-eDP1: SUCCESS (3.945s)
[493.779517] Starting dynamic subtest: B-eDP1
[498.406796] Dynamic subtest B-eDP1: SUCCESS (4.632s)
[498.415946] Starting dynamic subtest: C-eDP1
[503.053847] Dynamic subtest C-eDP1: SUCCESS (4.641s)
[503.070945] Starting dynamic subtest: D-eDP1
[507.677442] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[507.679784] Subtest dpms-vs-vblank-race: SUCCESS (17.853s)
[508.567272] [045/133] (518s left) kms_chamelium_color (degamma)
[508.670752] Subtest degamma: SKIP (0.000s)
[508.717162] [046/133] (518s left) api_intel_bb (add-remove-objects)
[508.776575] Starting subtest: add-remove-objects
[508.781532] Subtest add-remove-objects: SUCCESS (0.007s)
[508.889577] [047/133] (518s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[509.005587] Starting subtest: cursor-vs-flip-atomic
[538.347391] Subtest cursor-vs-flip-atomic: SUCCESS (29.336s)
[539.201168] [048/133] (488s left) gem_userptr_blits (readonly-pwrite-unsync)
[539.261247] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[539.399020] [049/133] (488s left) gem_exec_schedule (wide)
[539.605447] Starting subtest: wide
[539.607692] Starting dynamic subtest: rcs0
[550.568795] Dynamic subtest rcs0: SUCCESS (10.966s)
[550.580447] Starting dynamic subtest: vcs0
[562.163655] Dynamic subtest vcs0: SUCCESS (11.595s)
[562.174001] Starting dynamic subtest: vcs1
[574.401592] Dynamic subtest vcs1: SUCCESS (12.236s)
[574.429485] Starting dynamic subtest: vecs0
[586.455429] Dynamic subtest vecs0: SUCCESS (12.051s)
[586.466090] Starting dynamic subtest: ccs0
[600.794209] Dynamic subtest ccs0: SUCCESS (14.335s)
[600.797229] Subtest wide: SUCCESS (61.191s)
[602.356807] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[602.360461] [050/133] (425s left) kms_force_connector_basic (force-load-detect)
[602.444610] Starting subtest: force-load-detect
[602.449654] Subtest force-load-detect: SKIP (0.000s)
[602.600557] [051/133] (425s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[602.666923] Starting subtest: multi-wait-all-for-submit-submitted
[602.765593] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[602.858182] [052/133] (424s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[602.979612] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[620.323804] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.339s)
[621.134275] [053/133] (406s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[621.245171] Starting subtest: yf-tiled-8bpp-rotate-270
[621.250560] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[621.375929] [054/133] (406s left) core_auth (getclient-simple)
[621.417789] Starting subtest: getclient-simple
[621.438266] Subtest getclient-simple: SUCCESS (0.023s)
[621.548334] [055/133] (406s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[621.661255] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[621.665989] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[621.771996] [056/133] (406s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[621.873083] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[621.878820] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[621.997846] [057/133] (405s left) gem_exec_reloc (basic-wc)
[622.062817] Subtest basic-wc: SKIP (0.000s)
[622.152924] [058/133] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[622.260176] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[622.263547] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[622.390328] [059/133] (405s left) syncobj_basic (illegal-fd-to-handle)
[622.441852] Starting subtest: illegal-fd-to-handle
[622.443959] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[622.554375] [060/133] (405s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[622.640470] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[622.644601] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[622.726509] [061/133] (405s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[622.821999] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[622.826211] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[622.942277] [062/133] (405s left) kms_flip (wf_vblank-ts-check)
[623.039270] Starting subtest: wf_vblank-ts-check
[623.041337] Starting dynamic subtest: A-eDP1
[631.978958] Dynamic subtest A-eDP1: SUCCESS (8.940s)
[631.992636] Starting dynamic subtest: B-eDP1
[640.908885] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[640.918700] Starting dynamic subtest: C-eDP1
[649.829983] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[649.839320] Starting dynamic subtest: D-eDP1
[658.765898] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[658.768815] Subtest wf_vblank-ts-check: SUCCESS (35.724s)
[660.005572] [063/133] (368s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[660.091984] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[660.094572] Starting dynamic subtest: pipe-A-eDP-1
[660.119450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[660.130563] Starting dynamic subtest: pipe-B-eDP-1
[660.155603] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[660.164554] Starting dynamic subtest: pipe-C-eDP-1
[660.189773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[660.200721] Starting dynamic subtest: pipe-D-eDP-1
[660.227341] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[660.231858] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[662.376139] [064/133] (365s left) kms_psr (fbc-pr-cursor-blt)
[662.482687] Starting subtest: fbc-pr-cursor-blt
[662.487664] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[662.581494] [065/133] (365s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[662.680708] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[662.682922] Starting dynamic subtest: pipe-A
[662.699245] Dynamic subtest pipe-A: SKIP (0.016s)
[662.713168] Starting dynamic subtest: pipe-B
[662.730536] Dynamic subtest pipe-B: SKIP (0.028s)
[662.739634] Starting dynamic subtest: pipe-C
[662.757277] Dynamic subtest pipe-C: SKIP (0.029s)
[662.765814] Starting dynamic subtest: pipe-D
[662.787572] Dynamic subtest pipe-D: SKIP (0.028s)
[662.792557] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.104s)
[662.881650] [066/133] (365s left) sw_sync (alloc_timeline)
[662.913664] Starting subtest: alloc_timeline
[662.916257] Subtest alloc_timeline: SUCCESS (0.000s)
[662.982090] [067/133] (365s left) kms_selftest (drm_format_helper)
[663.018584] Starting subtest: drm_format_helper
[663.053246] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[663.204740] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.152s)
[663.219672] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[663.356748] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.149s)
[663.367080] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[663.520971] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.163s)
[663.530356] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[663.659557] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.136s)
[663.669247] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[663.816993] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.155s)
[663.826771] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[663.972212] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.154s)
[663.981598] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[664.111760] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.138s)
[664.121933] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[664.263272] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.150s)
[664.272816] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[664.402189] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.141s)
[664.412597] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[664.542826] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.138s)
[664.552939] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[664.689963] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.146s)
[664.699713] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[664.832877] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.143s)
[664.842812] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[664.973854] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.140s)
[664.983212] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[665.126439] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.149s)
[665.136483] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[665.283246] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.157s)
[665.293708] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[665.431850] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.150s)
[665.441963] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[665.582018] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.150s)
[665.584477] Subtest drm_format_helper: SUCCESS (2.567s)
[665.809237] [068/133] (362s left) gem_userptr_blits (sync-unmap-cycles)
[665.890634] Starting subtest: sync-unmap-cycles
[671.259023] Subtest sync-unmap-cycles: SUCCESS (5.369s)
[671.431356] [069/133] (356s left) perf_pmu (rc6)
[671.474670] Starting subtest: rc6
[671.476889] Starting dynamic subtest: gt0
[677.861301] Dynamic subtest gt0: SUCCESS (6.386s)
[677.873631] Starting dynamic subtest: runtime-pm-gt0
[685.586193] Dynamic subtest runtime-pm-gt0: SUCCESS (7.724s)
[685.598993] Starting dynamic subtest: runtime-pm-long-gt0
[698.035315] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.448s)
[698.045958] Starting dynamic subtest: other-idle-gt0
[704.379332] Dynamic subtest other-idle-gt0: SUCCESS (6.342s)
[704.390022] Starting dynamic subtest: gt1
[710.721829] Dynamic subtest gt1: SUCCESS (6.340s)
[710.733935] Starting dynamic subtest: runtime-pm-gt1
[718.157266] Dynamic subtest runtime-pm-gt1: SUCCESS (7.432s)
[718.169980] Starting dynamic subtest: runtime-pm-long-gt1
[730.605493] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.445s)
[730.617713] Starting dynamic subtest: other-idle-gt1
[736.948278] Dynamic subtest other-idle-gt1: SUCCESS (6.341s)
[736.951008] Subtest rc6: SUCCESS (65.477s)
[738.206789] [070/133] (290s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[738.302626] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[738.315601] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[738.369136] [071/133] (290s left) gem_exec_reloc (basic-cpu)
[738.432693] Subtest basic-cpu: SKIP (0.000s)
[738.521435] [072/133] (289s left) kms_psr (psr2-primary-mmap-cpu)
[738.650494] Starting subtest: psr2-primary-mmap-cpu
[738.652453] Starting dynamic subtest: eDP-1
[740.417676] Dynamic subtest eDP-1: SUCCESS (1.766s)
[740.420357] Subtest psr2-primary-mmap-cpu: SUCCESS (1.767s)
[741.282655] [073/133] (287s left) sriov_basic (enable-vfs-autoprobe-on)
[741.347563] Starting subtest: enable-vfs-autoprobe-on
[741.349991] Starting dynamic subtest: numvfs-1
[741.425641] Dynamic subtest numvfs-1: FAIL (0.005s)
[741.435644] Starting dynamic subtest: numvfs-2
[741.510696] Dynamic subtest numvfs-2: FAIL (0.003s)
[741.519969] Starting dynamic subtest: numvfs-3
[741.595727] Dynamic subtest numvfs-3: FAIL (0.003s)
[741.604551] Starting dynamic subtest: numvfs-4
[741.680743] Dynamic subtest numvfs-4: FAIL (0.003s)
[741.690074] Starting dynamic subtest: numvfs-5
[741.774762] Dynamic subtest numvfs-5: FAIL (0.004s)
[741.784870] Starting dynamic subtest: numvfs-6
[741.870514] Dynamic subtest numvfs-6: FAIL (0.004s)
[741.880954] Starting dynamic subtest: numvfs-7
[741.965980] Dynamic subtest numvfs-7: FAIL (0.003s)
[741.976380] Starting dynamic subtest: numvfs-random
[742.060409] Dynamic subtest numvfs-random: FAIL (0.004s)
[742.070387] Starting dynamic subtest: numvfs-all
[742.154968] Dynamic subtest numvfs-all: FAIL (0.551s)
[742.157679] Subtest enable-vfs-autoprobe-on: FAIL (0.587s)
[742.198668] [074/133] (286s left) i915_pm_freq_api (freq-reset)
[742.256340] Starting subtest: freq-reset
[742.258784] Starting dynamic subtest: gt0
[742.451716] Dynamic subtest gt0: SUCCESS (0.194s)
[742.463691] Starting dynamic subtest: gt1
[742.625645] Dynamic subtest gt1: SUCCESS (0.169s)
[742.628810] Subtest freq-reset: SUCCESS (0.365s)
[742.677070] [075/133] (285s left) gem_exec_nop (basic-parallel)
[742.748695] Starting subtest: basic-parallel
[759.075450] Subtest basic-parallel: SUCCESS (16.340s)
[759.287172] [076/133] (269s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[759.384699] Starting subtest: primary-y-tiled-reflect-x-180
[759.444865] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[759.526880] [077/133] (269s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[759.630464] Starting subtest: fbc-psr2-cursor-plane-update-sf
[759.632958] Starting dynamic subtest: pipe-A-eDP-1
[759.702773] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[759.712955] Starting dynamic subtest: pipe-B-eDP-1
[760.874633] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[760.879847] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.247s)
[762.131308] [078/133] (266s left) syncobj_timeline (reset-multiple-signaled)
[762.191998] Starting subtest: reset-multiple-signaled
[762.195015] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[762.265529] [079/133] (266s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[762.370938] Starting subtest: 4-tiled-8bpp-rotate-270
[762.392977] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.022s)
[762.510514] [080/133] (266s left) gem_spin_batch (resubmit-new)
[762.576861] Starting subtest: resubmit-new
[762.579662] Starting dynamic subtest: rcs0
[762.584788] Dynamic subtest rcs0: SUCCESS (0.008s)
[762.595504] Starting dynamic subtest: bcs0
[762.597921] Dynamic subtest bcs0: SUCCESS (0.004s)
[762.607378] Starting dynamic subtest: vcs0
[762.609666] Dynamic subtest vcs0: SUCCESS (0.004s)
[762.618725] Starting dynamic subtest: vcs1
[762.620753] Dynamic subtest vcs1: SUCCESS (0.004s)
[762.629725] Starting dynamic subtest: vecs0
[762.631761] Dynamic subtest vecs0: SUCCESS (0.004s)
[762.641588] Starting dynamic subtest: ccs0
[762.643707] Dynamic subtest ccs0: SUCCESS (0.003s)
[762.645844] Subtest resubmit-new: SUCCESS (0.032s)
[764.154066] [081/133] (264s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[764.276362] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[765.289630] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.012s)
[765.413318] [082/133] (263s left) kms_pm_dc (dc3co-vpb-simulation)
[766.511754] Starting subtest: dc3co-vpb-simulation
[775.146245] Subtest dc3co-vpb-simulation: SKIP (8.630s)
[775.269241] [083/133] (253s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[775.374552] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[775.379738] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[775.459947] [084/133] (253s left) perf_pmu (init-busy)
[775.501589] Starting subtest: init-busy
[775.503819] Starting dynamic subtest: rcs0
[775.506318] Dynamic subtest rcs0: SUCCESS (0.001s)
[775.516484] Starting dynamic subtest: bcs0
[775.518751] Dynamic subtest bcs0: SUCCESS (0.001s)
[775.527886] Starting dynamic subtest: vcs0
[775.530232] Dynamic subtest vcs0: SUCCESS (0.001s)
[775.539348] Starting dynamic subtest: vcs1
[775.541570] Dynamic subtest vcs1: SUCCESS (0.001s)
[775.550740] Starting dynamic subtest: vecs0
[775.552986] Dynamic subtest vecs0: SUCCESS (0.001s)
[775.561858] Starting dynamic subtest: ccs0
[775.564220] Dynamic subtest ccs0: SUCCESS (0.000s)
[775.566286] Subtest init-busy: SUCCESS (0.007s)
[775.608663] [085/133] (253s left) gem_sync (basic-all)
[775.683547] Starting subtest: basic-all
[780.067101] Subtest basic-all: SUCCESS (4.396s)
[780.232931] [086/133] (248s left) syncobj_wait (single-wait-for-submit-submitted)
[780.302990] Starting subtest: single-wait-for-submit-submitted
[780.406329] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[780.474381] [087/133] (248s left) gem_exec_reloc (basic-active)
[780.528983] Subtest basic-active: SKIP (0.000s)
[780.622084] [088/133] (248s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[780.717737] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[780.720592] Starting dynamic subtest: pipe-A
[780.741098] Dynamic subtest pipe-A: SKIP (0.018s)
[780.750951] Starting dynamic subtest: pipe-B
[780.772484] Dynamic subtest pipe-B: SKIP (0.029s)
[780.782558] Starting dynamic subtest: pipe-C
[780.802520] Dynamic subtest pipe-C: SKIP (0.030s)
[780.812468] Starting dynamic subtest: pipe-D
[780.835656] Dynamic subtest pipe-D: SKIP (0.030s)
[780.840313] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.110s)
[780.925610] [089/133] (248s left) gem_ctx_isolation (nonpriv)
[781.002721] Starting subtest: nonpriv
[781.005850] Starting dynamic subtest: rcs0
[781.238560] Dynamic subtest rcs0: SUCCESS (0.235s)
[781.249821] Starting dynamic subtest: bcs0
[781.520971] Dynamic subtest bcs0: SUCCESS (0.282s)
[781.531973] Starting dynamic subtest: vcs0
[781.824264] Dynamic subtest vcs0: SUCCESS (0.303s)
[781.834013] Starting dynamic subtest: vcs1
[783.402680] Dynamic subtest vcs1: SUCCESS (1.577s)
[783.414603] Starting dynamic subtest: vecs0
[785.415566] Dynamic subtest vecs0: SUCCESS (2.012s)
[785.426009] Starting dynamic subtest: ccs0
[787.411620] Dynamic subtest ccs0: SUCCESS (1.994s)
[787.414243] Subtest nonpriv: SUCCESS (6.408s)
[787.650682] [090/133] (241s left) kms_async_flips (crc)
[787.756783] Starting subtest: crc
[788.127787] Starting dynamic subtest: pipe-A-eDP-1
[791.064574] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.935s)
[791.447351] Starting dynamic subtest: pipe-B-eDP-1
[794.298726] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.864s)
[794.670480] Starting dynamic subtest: pipe-C-eDP-1
[797.509789] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.846s)
[797.872731] Starting dynamic subtest: pipe-D-eDP-1
[800.745828] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.881s)
[800.748800] Subtest crc: SUCCESS (12.988s)
[801.896196] [091/133] (227s left) i915_pm_rps (engine-order)
[801.962541] Starting subtest: engine-order
[808.478875] Subtest engine-order: SUCCESS (6.514s)
[808.616447] [092/133] (220s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[808.719580] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[813.314776] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.598s)
[814.404899] [093/133] (214s left) gem_exec_fence (parallel)
[814.585684] Starting subtest: parallel
[814.588156] Starting dynamic subtest: rcs0
[816.734701] Dynamic subtest rcs0: SUCCESS (2.149s)
[816.744150] Starting dynamic subtest: bcs0
[818.890481] Dynamic subtest bcs0: SUCCESS (2.154s)
[818.900947] Starting dynamic subtest: vcs0
[821.038852] Dynamic subtest vcs0: SUCCESS (2.147s)
[821.048518] Starting dynamic subtest: vcs1
[823.193899] Dynamic subtest vcs1: SUCCESS (2.154s)
[823.204952] Starting dynamic subtest: vecs0
[825.343964] Dynamic subtest vecs0: SUCCESS (2.149s)
[825.354541] Starting dynamic subtest: ccs0
[827.493989] Dynamic subtest ccs0: SUCCESS (2.149s)
[827.496320] Subtest parallel: SUCCESS (12.907s)
[828.225829] [094/133] (201s left) syncobj_timeline (wait-all-for-submit-complex)
[828.281974] Starting subtest: wait-all-for-submit-complex
[828.520564] Subtest wait-all-for-submit-complex: SUCCESS (0.215s)
[828.565317] [095/133] (200s left) kms_lease (lease-invalid-connector)
[828.674748] Starting subtest: lease-invalid-connector
[828.677375] Starting dynamic subtest: pipe-A-eDP-1
[828.679774] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[828.689234] Starting dynamic subtest: pipe-B-eDP-1
[828.691808] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[828.701637] Starting dynamic subtest: pipe-C-eDP-1
[828.704013] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[828.713913] Starting dynamic subtest: pipe-D-eDP-1
[828.716354] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[828.718692] Subtest lease-invalid-connector: SUCCESS (0.004s)
[828.757813] [096/133] (200s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[828.826871] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[828.832408] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[828.991776] [097/133] (200s left) kms_psr (fbc-psr2-sprite-plane-move)
[829.089188] Starting subtest: fbc-psr2-sprite-plane-move
[829.091784] Starting dynamic subtest: eDP-1
[829.096738] Dynamic subtest eDP-1: SKIP (0.000s)
[829.101700] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[829.148751] [098/133] (200s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[829.250959] Starting subtest: y-tiled-64bpp-rotate-270
[829.255981] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s)
[829.352844] [099/133] (200s left) gem_exec_schedule (semaphore-noskip)
[829.432692] Starting subtest: semaphore-noskip
[829.867787] Subtest semaphore-noskip: SUCCESS (0.443s)
[830.206743] [100/133] (199s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[830.326886] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[830.331994] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[830.414297] [101/133] (199s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[830.547706] Starting subtest: flip-vs-cursor-busy-crc-atomic
[831.409957] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.861s)
[832.230569] [102/133] (197s left) gem_exec_flush (basic-uc-pro-default)
[832.304387] Starting subtest: basic-uc-pro-default
[837.761932] Subtest basic-uc-pro-default: SUCCESS (5.460s)
[837.928876] [103/133] (191s left) gem_exec_balancer (bonded-dual)
[837.998552] Starting subtest: bonded-dual
[838.003717] Subtest bonded-dual: SKIP (0.000s)
[838.289599] [104/133] (191s left) kms_psr (fbc-pr-sprite-blt)
[838.378103] Starting subtest: fbc-pr-sprite-blt
[838.382948] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[838.429066] [105/133] (191s left) gem_gpgpu_fill (offset-16x16)
[838.485855] Starting subtest: offset-16x16
[838.492675] Subtest offset-16x16: SUCCESS (0.009s)
[838.622291] [106/133] (191s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[838.720694] Starting subtest: plane-primary-overlay-mutable-zpos
[842.213691] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.488s)
[843.383103] [107/133] (186s left) gem_pread (snoop)
[843.443859] Subtest snoop: SKIP (0.000s)
[843.525316] [108/133] (186s left) gem_mmap_gtt (hang-busy)
[843.579433] Subtest hang-busy: SKIP (0.000s)
[843.652933] [109/133] (186s left) gem_mmap_wc (fault-concurrent)
[843.726568] Subtest fault-concurrent: SKIP (0.000s)
[843.797105] [110/133] (186s left) kms_content_protection (suspend-resume)
[843.946668] Starting subtest: suspend-resume
[843.952016] Subtest suspend-resume: SKIP (0.000s)
[844.053788] [111/133] (186s left) gem_exec_alignment (forked)
[844.121107] Starting subtest: forked
[886.614384] Subtest forked: SUCCESS (42.484s)
[886.812142] [112/133] (143s left) syncobj_wait (multi-wait-all-submitted-signaled)
[886.912958] Starting subtest: multi-wait-all-submitted-signaled
[887.022402] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[887.082874] [113/133] (143s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[887.154950] Starting subtest: invalid-bsd2-flag-on-blt
[887.157739] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[887.253292] [114/133] (143s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[887.377945] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[887.380427] Starting dynamic subtest: pipe-A-default-mode
[888.581993] Dynamic subtest pipe-A-default-mode: SKIP (1.201s)
[888.586432] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.203s)
[888.716885] [115/133] (141s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[888.782384] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[888.887472] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[888.942539] [116/133] (141s left) gem_madvise (dontneed-after-mmap)
[888.985791] Starting subtest: dontneed-after-mmap
[889.005822] Subtest dontneed-after-mmap: SUCCESS (0.025s)
[889.091624] [117/133] (141s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[889.192700] Starting subtest: dsc-fractional-bpp-with-bpc
[889.228688] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.002s)
[889.268513] [118/133] (141s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[889.375329] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[893.383282] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.011s)
[894.523427] [119/133] (135s left) kms_ccs (bad-rotation-90-yf-tiled-ccs)
[894.628170] Starting subtest: bad-rotation-90-yf-tiled-ccs
[894.630738] Starting dynamic subtest: pipe-A-eDP-1
[894.654513] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[894.665702] Starting dynamic subtest: pipe-B-eDP-1
[894.691030] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[894.700675] Starting dynamic subtest: pipe-C-eDP-1
[894.725290] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[894.734536] Starting dynamic subtest: pipe-D-eDP-1
[894.759895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[894.765384] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s)
[896.787043] [120/133] (133s left) gem_mmap_offset (pf-nonblock)
[896.850395] Starting subtest: pf-nonblock
[896.855791] Subtest pf-nonblock: SUCCESS (0.006s)
[896.971763] [121/133] (133s left) kms_cursor_crc (cursor-offscreen-512x170)
[897.277741] Starting subtest: cursor-offscreen-512x170
[897.283660] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[897.413700] [122/133] (133s left) sw_sync (sync_multi_timeline_wait)
[897.454572] Starting subtest: sync_multi_timeline_wait
[897.457216] Subtest sync_multi_timeline_wait: SUCCESS (0.001s)
[897.496724] [123/133] (133s left) gem_ctx_persistence (processes)
[897.558712] Starting subtest: processes
[899.070232] Subtest processes: SUCCESS (1.511s)
[899.128969] [124/133] (131s left) kms_plane_alpha_blend (coverage-7efc)
[899.238321] Starting subtest: coverage-7efc
[899.537299] Starting dynamic subtest: pipe-A-eDP-1
[900.145742] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[900.181566] Starting dynamic subtest: pipe-D-eDP-1
[901.458106] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[901.460472] Subtest coverage-7efc: SUCCESS (2.219s)
[902.253488] [125/133] (128s left) i915_drm_fdinfo (memory-info-idle)
[902.300449] Starting subtest: memory-info-idle
[902.302936] Starting dynamic subtest: smem0
[902.374621] Dynamic subtest smem0: SUCCESS (0.075s)
[902.377780] Subtest memory-info-idle: SUCCESS (0.077s)
[902.429595] [126/133] (128s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[902.535368] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[902.537954] Starting dynamic subtest: pipe-A-eDP-1
[902.630159] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[902.642429] Starting dynamic subtest: pipe-B-eDP-1
[903.755759] Dynamic subtest pipe-B-eDP-1: SKIP (1.124s)
[903.760581] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.226s)
[904.928260] [127/133] (125s left) vgem_slow (nohang)
[904.972864] Starting subtest: nohang
[915.201229] Subtest nohang: SUCCESS (10.227s)
[915.245164] [128/133] (115s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[915.344692] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[915.349538] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[915.395136] [129/133] (115s left) syncobj_wait (wait-all-delayed-signal)
[915.451336] Starting subtest: wait-all-delayed-signal
[915.552429] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[915.612989] [130/133] (115s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[915.708940] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[915.713817] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[915.759248] [131/133] (115s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[915.848646] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[915.851274] Starting dynamic subtest: pipe-A-eDP-1
[915.876650] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[915.892964] Starting dynamic subtest: pipe-B-eDP-1
[915.918895] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[915.929760] Starting dynamic subtest: pipe-C-eDP-1
[915.955578] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[915.965500] Starting dynamic subtest: pipe-D-eDP-1
[915.991540] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[915.996402] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[918.006677] [132/133] (113s left) kms_getfb (getfb-handle-closed)
[918.097540] Starting subtest: getfb-handle-closed
[918.100104] Subtest getfb-handle-closed: SUCCESS (0.000s)
[918.186694] [133/133] (112s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[918.283989] Starting subtest: extended-pageflip-modeset-hang-oldfb
[918.286729] Starting dynamic subtest: pipe-A
[926.200470] Dynamic subtest pipe-A: SUCCESS (7.921s)
[926.212017] Starting dynamic subtest: pipe-D
[934.836539] Dynamic subtest pipe-D: SUCCESS (8.633s)
[934.838946] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.558s)
[935.668146] 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.