[57.656858] Initializing watchdogs
[57.656913]   /dev/watchdog0
[57.671798] [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.676537] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.678960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.682277] [001/132] (960s left) kms_lease (simple-lease)
[57.806486] Starting subtest: simple-lease
[57.808631] Starting dynamic subtest: pipe-A-eDP-1
[58.367336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.570s)
[58.375612] Starting dynamic subtest: pipe-B-eDP-1
[59.798299] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[59.809085] Starting dynamic subtest: pipe-C-eDP-1
[61.275569] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.489s)
[61.283154] Starting dynamic subtest: pipe-D-eDP-1
[62.696193] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.429s)
[62.698076] Subtest simple-lease: SUCCESS (4.941s)
[63.515907] [002/132] (954s left) kms_psr (psr-no-drrs)
[63.614041] Starting subtest: psr-no-drrs
[63.616278] Starting dynamic subtest: eDP-1
[65.297066] Dynamic subtest eDP-1: SUCCESS (1.692s)
[65.299317] Subtest psr-no-drrs: SUCCESS (1.693s)
[66.184193] [003/132] (952s left) kms_content_protection (type1)
[66.319978] Starting subtest: type1
[66.324284] Subtest type1: SKIP (0.000s)
[66.426960] [004/132] (951s left) kms_pipe_crc_basic (nonblocking-crc)
[66.527136] Starting subtest: nonblocking-crc
[66.529419] Starting dynamic subtest: pipe-A-eDP-1
[67.304030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s)
[67.313867] Starting dynamic subtest: pipe-B-eDP-1
[68.785435] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s)
[68.795166] Starting dynamic subtest: pipe-C-eDP-1
[70.158070] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[70.166163] Starting dynamic subtest: pipe-D-eDP-1
[71.597296] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.440s)
[71.599559] Subtest nonblocking-crc: SUCCESS (5.084s)
[72.476189] [005/132] (945s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[72.752112] Starting subtest: 2x-plain-flip-ts-check-interruptible
[72.764874] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s)
[72.936221] [006/132] (945s left) gem_exec_reloc (basic-wc)
[73.048844] Subtest basic-wc: SKIP (0.000s)
[73.178379] [007/132] (945s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[73.357598] Starting subtest: fbc-rgb565-draw-render
[77.591463] Subtest fbc-rgb565-draw-render: SUCCESS (4.243s)
[78.774118] [008/132] (939s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[78.844108] Subtest no-spare-fences-busy: SKIP (0.000s)
[78.919719] [009/132] (939s left) kms_vblank (wait-forked-hang)
[79.023502] Starting subtest: wait-forked-hang
[79.025756] Starting dynamic subtest: pipe-A-eDP-1
[105.094251] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.069s)
[105.108754] Starting dynamic subtest: pipe-D-eDP-1
[130.065874] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.969s)
[130.068142] Subtest wait-forked-hang: SUCCESS (51.044s)
[130.932735] [010/132] (887s left) gem_exec_whisper (basic-fds-forked)
[130.990674] Starting subtest: basic-fds-forked
[154.985588] Subtest basic-fds-forked: SUCCESS (23.990s)
[155.167964] [011/132] (863s left) kms_chamelium_audio (dp-audio-edid)
[155.549645] Subtest dp-audio-edid: SKIP (0.000s)
[156.340101] [012/132] (862s left) gem_exec_schedule (submit-golden-slice)
[156.400998] Starting subtest: submit-golden-slice
[156.402924] Starting dynamic subtest: rcs0
[156.430184] Dynamic subtest rcs0: SUCCESS (0.037s)
[156.442862] Starting dynamic subtest: bcs0
[156.463434] Dynamic subtest bcs0: SUCCESS (0.033s)
[156.472356] Starting dynamic subtest: vcs0
[156.495253] Dynamic subtest vcs0: SUCCESS (0.032s)
[156.504513] Starting dynamic subtest: vcs1
[156.529338] Dynamic subtest vcs1: SUCCESS (0.034s)
[156.538300] Starting dynamic subtest: vecs0
[156.560873] Dynamic subtest vecs0: SUCCESS (0.031s)
[156.571899] Starting dynamic subtest: ccs0
[156.591277] Dynamic subtest ccs0: SUCCESS (0.030s)
[156.593674] Subtest submit-golden-slice: SUCCESS (0.199s)
[158.363215] [013/132] (860s left) syncobj_eventfd (invalid-illegal-eventfd)
[158.423074] Starting subtest: invalid-illegal-eventfd
[158.425362] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[158.529460] [014/132] (860s left) gem_close_race (multigpu-basic-process)
[158.594773] Starting subtest: multigpu-basic-process
[158.599351] Subtest multigpu-basic-process: SKIP (0.000s)
[158.825201] [015/132] (859s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[158.924673] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[158.926615] Starting dynamic subtest: pipe-A-eDP-1
[175.062290] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.331s)
[175.076359] Starting dynamic subtest: pipe-B-eDP-1
[192.007410] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s)
[192.018418] Starting dynamic subtest: pipe-C-eDP-1
[208.939960] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[208.951348] Starting dynamic subtest: pipe-D-eDP-1
[225.968147] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.403s)
[225.970505] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (9.592s)
[227.176660] [016/132] (791s left) kms_psr (fbc-pr-primary-blt)
[227.262447] Starting subtest: fbc-pr-primary-blt
[227.266967] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[227.342837] [017/132] (791s left) kms_cursor_edge_walk (128x128-top-bottom)
[227.432135] Starting subtest: 128x128-top-bottom
[227.434486] Starting dynamic subtest: pipe-A-eDP-1
[230.873335] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.503s)
[230.883711] Starting dynamic subtest: pipe-D-eDP-1
[233.974425] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[233.976443] Subtest 128x128-top-bottom: SUCCESS (6.638s)
[234.800572] [018/132] (784s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[234.896469] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[234.900577] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[234.969201] [019/132] (783s left) kms_addfb_basic (bad-pitch-65536)
[235.029372] Starting subtest: bad-pitch-65536
[235.031678] Subtest bad-pitch-65536: SUCCESS (0.000s)
[235.186187] [020/132] (783s left) gem_exec_schedule (fairslice)
[235.258260] Starting subtest: fairslice
[235.260703] Starting dynamic subtest: rcs0
[237.274240] Dynamic subtest rcs0: SUCCESS (2.037s)
[237.283420] Starting dynamic subtest: bcs0
[239.294311] Dynamic subtest bcs0: SUCCESS (2.029s)
[239.306629] Starting dynamic subtest: vcs0
[241.315291] Dynamic subtest vcs0: SUCCESS (2.029s)
[241.324736] Starting dynamic subtest: vcs1
[243.336231] Dynamic subtest vcs1: SUCCESS (2.027s)
[243.345807] Starting dynamic subtest: vecs0
[245.359715] Dynamic subtest vecs0: SUCCESS (2.029s)
[245.371760] Starting dynamic subtest: ccs0
[247.379207] Dynamic subtest ccs0: SUCCESS (2.023s)
[247.381159] Subtest fairslice: SUCCESS (12.179s)
[247.671952] [021/132] (771s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[247.789680] Starting subtest: modeset-atomic-cursor-hotspot
[247.794104] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[247.934290] [022/132] (771s left) core_auth (basic-auth)
[247.993161] Starting subtest: basic-auth
[247.995512] Subtest basic-auth: SUCCESS (0.001s)
[248.107096] [023/132] (771s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[248.202236] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[248.298318] [024/132] (770s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[248.413991] Starting subtest: flip-vs-cursor-busy-crc-legacy
[249.136370] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.724s)
[249.949491] [025/132] (769s left) i915_drm_fdinfo (virtual-busy)
[249.991771] Starting subtest: virtual-busy
[249.995959] Subtest virtual-busy: SKIP (0.000s)
[250.059592] [026/132] (769s left) sriov_basic (bind-unbind-vf)
[250.105069] Starting subtest: bind-unbind-vf
[250.107533] Starting dynamic subtest: vf-1
[250.182868] Dynamic subtest vf-1: FAIL (0.020s)
[250.196394] Starting dynamic subtest: vf-2
[250.273514] Dynamic subtest vf-2: FAIL (0.004s)
[250.284250] Starting dynamic subtest: vf-3
[250.357666] Dynamic subtest vf-3: FAIL (0.004s)
[250.369089] Starting dynamic subtest: vf-4
[250.442781] Dynamic subtest vf-4: FAIL (0.004s)
[250.453639] Starting dynamic subtest: vf-5
[250.527693] Dynamic subtest vf-5: FAIL (0.004s)
[250.538868] Starting dynamic subtest: vf-6
[250.612197] Dynamic subtest vf-6: FAIL (0.004s)
[250.623080] Starting dynamic subtest: vf-7
[250.698519] Dynamic subtest vf-7: FAIL (0.004s)
[250.707965] Starting dynamic subtest: vf-random
[250.783970] Dynamic subtest vf-random: FAIL (0.004s)
[250.794985] Starting dynamic subtest: vf-last
[250.869010] Dynamic subtest vf-last: FAIL (0.529s)
[250.870998] Subtest bind-unbind-vf: FAIL (0.580s)
[250.907247] [027/132] (768s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[251.003897] Starting subtest: x-tiled-8bpp-rotate-90
[251.025042] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s)
[251.125254] [028/132] (768s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[251.214014] Starting subtest: bad-pixel-format-y-tiled-ccs
[251.215948] Starting dynamic subtest: pipe-A-eDP-1
[251.234764] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[251.245563] Starting dynamic subtest: pipe-B-eDP-1
[251.262889] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[251.272404] Starting dynamic subtest: pipe-C-eDP-1
[251.289814] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[251.299395] Starting dynamic subtest: pipe-D-eDP-1
[251.317952] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[251.321873] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[253.512442] [029/132] (765s left) gem_exec_balancer (hang)
[253.783594] Starting subtest: hang
[255.870201] Subtest hang: SUCCESS (2.092s)
[256.011977] [030/132] (763s left) gem_sync (basic-store-each)
[256.095308] Starting subtest: basic-store-each
[258.543175] Subtest basic-store-each: SUCCESS (2.456s)
[258.733239] [031/132] (760s left) gem_ctx_param (set-priority-not-supported)
[258.784895] Starting subtest: set-priority-not-supported
[258.789445] Subtest set-priority-not-supported: SKIP (0.000s)
[258.863236] [032/132] (760s left) sysfs_heartbeat_interval (idempotent)
[258.919500] Starting subtest: idempotent
[258.921982] Starting dynamic subtest: vecs0
[258.924363] Dynamic subtest vecs0: SUCCESS (0.001s)
[258.937755] Starting dynamic subtest: ccs0
[258.940071] Dynamic subtest ccs0: SUCCESS (0.003s)
[258.949382] Starting dynamic subtest: vcs0
[258.951271] Dynamic subtest vcs0: SUCCESS (0.000s)
[258.960566] Starting dynamic subtest: bcs0
[258.962508] Dynamic subtest bcs0: SUCCESS (0.002s)
[258.972135] Starting dynamic subtest: rcs0
[258.974320] Dynamic subtest rcs0: SUCCESS (0.001s)
[258.983839] Starting dynamic subtest: vcs1
[258.985715] Dynamic subtest vcs1: SUCCESS (0.000s)
[258.987642] Subtest idempotent: SUCCESS (0.011s)
[259.050743] [033/132] (760s left) kms_busy (extended-pageflip-hang-oldfb)
[259.160839] Starting subtest: extended-pageflip-hang-oldfb
[259.163273] Starting dynamic subtest: pipe-A
[259.569637] Dynamic subtest pipe-A: SUCCESS (0.408s)
[259.581099] Starting dynamic subtest: pipe-D
[260.719100] Dynamic subtest pipe-D: SUCCESS (1.146s)
[260.721412] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.558s)
[261.577799] [034/132] (757s left) gem_partial_pwrite_pread (writes-after-reads)
[261.635302] Subtest writes-after-reads: SKIP (0.000s)
[261.701832] [035/132] (757s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[261.741512] Starting subtest: multi-wait-for-submit-unsubmitted
[261.848312] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[261.928567] [036/132] (757s left) kms_psr (pr-cursor-plane-move)
[262.022945] Starting subtest: pr-cursor-plane-move
[262.027450] Subtest pr-cursor-plane-move: SKIP (0.000s)
[262.105128] [037/132] (757s left) gem_exec_parallel (basic)
[262.166769] Starting subtest: basic
[262.169068] Starting dynamic subtest: rcs0
[263.616791] Dynamic subtest rcs0: SUCCESS (1.452s)
[263.627223] Starting dynamic subtest: bcs0
[265.081704] Dynamic subtest bcs0: SUCCESS (1.464s)
[265.092995] Starting dynamic subtest: vcs0
[266.875211] Dynamic subtest vcs0: SUCCESS (1.791s)
[266.886273] Starting dynamic subtest: vcs1
[268.925280] Dynamic subtest vcs1: SUCCESS (2.048s)
[268.936481] Starting dynamic subtest: vecs0
[270.843168] Dynamic subtest vecs0: SUCCESS (1.915s)
[270.858894] Starting dynamic subtest: ccs0
[272.353755] Dynamic subtest ccs0: SUCCESS (1.510s)
[272.356037] Subtest basic: SUCCESS (10.189s)
[272.553312] [038/132] (747s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[272.619579] Starting subtest: y-tiled-to-vebox-yf-tiled
[272.624159] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[272.801933] [039/132] (746s left) kms_properties (colorop-properties-atomic)
[272.906359] Starting subtest: colorop-properties-atomic
[272.908578] Starting dynamic subtest: pipe-A-eDP-1
[273.293062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.385s)
[273.304127] Starting dynamic subtest: pipe-B-eDP-1
[274.346584] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.053s)
[274.357917] Starting dynamic subtest: pipe-C-eDP-1
[275.475577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s)
[275.485981] Starting dynamic subtest: pipe-D-eDP-1
[276.608300] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[276.610663] Subtest colorop-properties-atomic: SUCCESS (3.703s)
[277.413887] [040/132] (742s left) gem_exec_schedule (preempt)
[277.480366] Starting subtest: preempt
[277.482402] Starting dynamic subtest: rcs0
[277.499221] Dynamic subtest rcs0: SUCCESS (0.027s)
[277.509516] Starting dynamic subtest: bcs0
[277.521271] Dynamic subtest bcs0: SUCCESS (0.021s)
[277.532722] Starting dynamic subtest: vcs0
[277.546919] Dynamic subtest vcs0: SUCCESS (0.025s)
[277.556956] Starting dynamic subtest: vcs1
[277.569574] Dynamic subtest vcs1: SUCCESS (0.022s)
[277.580275] Starting dynamic subtest: vecs0
[277.596569] Dynamic subtest vecs0: SUCCESS (0.026s)
[277.607678] Starting dynamic subtest: ccs0
[277.621404] Dynamic subtest ccs0: SUCCESS (0.024s)
[277.623689] Subtest preempt: SUCCESS (0.150s)
[278.982449] [041/132] (740s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[279.086620] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[288.821013] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.740s)
[288.946432] [042/132] (730s left) gem_exec_reloc (basic-cpu-gtt-active)
[289.005889] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[289.087775] [043/132] (730s left) kms_flip (flip-vs-modeset-vs-hang)
[289.182572] Starting subtest: flip-vs-modeset-vs-hang
[289.184975] Starting dynamic subtest: A-eDP1
[340.375515] Dynamic subtest A-eDP1: SUCCESS (51.193s)
[340.386006] Starting dynamic subtest: D-eDP1
[390.354547] Dynamic subtest D-eDP1: SUCCESS (49.979s)
[390.357475] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.177s)
[390.752774] [044/132] (629s left) kms_big_fb (linear-16bpp-rotate-180)
[390.852990] Starting subtest: linear-16bpp-rotate-180
[392.221969] Subtest linear-16bpp-rotate-180: SUCCESS (1.369s)
[392.342985] [045/132] (627s left) syncobj_basic (bad-pad-fd-to-handle)
[392.394418] Starting subtest: bad-pad-fd-to-handle
[392.396451] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[392.515727] [046/132] (627s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[392.603973] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[392.607571] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[392.702707] [047/132] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[392.796452] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[396.573389] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.782s)
[397.733030] [048/132] (622s left) gem_mmap_offset (bad-flags)
[397.785997] Starting subtest: bad-flags
[397.788126] Subtest bad-flags: SUCCESS (0.000s)
[397.900857] [049/132] (622s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[398.004414] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[404.746569] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.748s)
[404.858253] [050/132] (615s left) gem_lmem_swapping (heavy-verify-random-ccs)
[404.906228] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[404.944858] [051/132] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[405.038363] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[405.042606] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[405.140436] [052/132] (615s left) kms_cursor_crc (cursor-onscreen-256x256)
[405.389108] Starting subtest: cursor-onscreen-256x256
[405.391365] Starting dynamic subtest: pipe-A-eDP-1
[407.510632] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s)
[407.543975] Starting dynamic subtest: pipe-D-eDP-1
[410.338738] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.803s)
[410.340616] Subtest cursor-onscreen-256x256: SUCCESS (4.950s)
[411.202854] [053/132] (609s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[411.292997] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[411.295208] Starting dynamic subtest: pipe-A-eDP-1
[411.317618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[411.328420] Starting dynamic subtest: pipe-B-eDP-1
[411.350274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[411.360036] Starting dynamic subtest: pipe-C-eDP-1
[411.382131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[411.394457] Starting dynamic subtest: pipe-D-eDP-1
[411.416963] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[411.421114] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[413.561923] [054/132] (606s left) gem_pread (display)
[413.627313] Subtest display: SKIP (0.000s)
[413.680919] [055/132] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[413.775375] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[413.779262] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[413.880798] [056/132] (606s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[413.989407] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[420.621404] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.637s)
[420.763257] [057/132] (599s left) gem_mmap_gtt (basic-short)
[420.831283] Subtest basic-short: SKIP (0.000s)
[420.893802] [058/132] (599s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[420.996138] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[421.000715] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[421.122058] [059/132] (599s left) kms_draw_crc (draw-method-pwrite)
[421.213463] Starting subtest: draw-method-pwrite
[421.215602] Starting dynamic subtest: xrgb8888-untiled
[421.822993] Dynamic subtest xrgb8888-untiled: SUCCESS (0.612s)
[421.833157] Starting dynamic subtest: rgb565-untiled
[422.289737] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[422.301072] Starting dynamic subtest: xrgb2101010-untiled
[422.855979] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s)
[422.866522] Starting dynamic subtest: xbgr16161616f-untiled
[423.644804] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.788s)
[423.655718] Starting dynamic subtest: xrgb8888-xtiled
[425.501303] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.855s)
[425.511032] Starting dynamic subtest: rgb565-xtiled
[426.622011] Dynamic subtest rgb565-xtiled: SUCCESS (1.121s)
[426.634808] Starting dynamic subtest: xrgb2101010-xtiled
[428.465920] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.842s)
[428.477598] Starting dynamic subtest: xbgr16161616f-xtiled
[431.909603] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.444s)
[431.921970] Starting dynamic subtest: xrgb8888-4tiled
[433.064361] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.154s)
[433.076761] Starting dynamic subtest: rgb565-4tiled
[433.643482] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s)
[433.654381] Starting dynamic subtest: xrgb2101010-4tiled
[434.787784] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.144s)
[434.803218] Starting dynamic subtest: xbgr16161616f-4tiled
[437.874545] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.087s)
[437.876908] Subtest draw-method-pwrite: SUCCESS (16.668s)
[437.969994] [060/132] (582s left) dumb_buffer (map-valid)
[438.028913] Starting subtest: map-valid
[438.031072] Subtest map-valid: SUCCESS (0.000s)
[438.144422] [061/132] (582s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[438.237245] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[438.241714] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[439.414020] [062/132] (581s left) kms_chamelium_color (gamma)
[439.508287] Subtest gamma: SKIP (0.000s)
[439.553968] [063/132] (581s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[439.664876] Starting subtest: yf-tiled-16bpp-rotate-90
[439.669256] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[439.757320] [064/132] (581s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[439.856702] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[440.978832] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.123s)
[441.079565] [065/132] (579s left) kms_getfb (getfb-handle-closed)
[441.179408] Starting subtest: getfb-handle-closed
[441.181365] Subtest getfb-handle-closed: SUCCESS (0.000s)
[441.270414] [066/132] (579s left) kms_vrr (seamless-rr-switch-vrr)
[441.361662] Starting subtest: seamless-rr-switch-vrr
[441.367011] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[441.432821] [067/132] (579s left) kms_panel_fitting (atomic-fastset)
[441.526489] Starting subtest: atomic-fastset
[441.528144] Starting dynamic subtest: pipe-A-eDP-1
[441.675515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[441.688605] Starting dynamic subtest: pipe-B-eDP-1
[442.873959] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[442.884825] Starting dynamic subtest: pipe-C-eDP-1
[444.071978] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.197s)
[444.082478] Starting dynamic subtest: pipe-D-eDP-1
[445.297973] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[445.300237] Subtest atomic-fastset: SUCCESS (3.774s)
[446.537894] [068/132] (574s left) gem_exec_fence (syncobj-invalid-wait)
[447.025830] Starting subtest: syncobj-invalid-wait
[447.028582] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[448.976554] [FACT gem_exec_fence (syncobj-invalid-wait)] new: kernel.kmod_is_loaded.vgem: true
[448.980972] [069/132] (571s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[449.079226] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[449.083534] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[449.176993] [070/132] (571s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[449.272686] Starting subtest: psr-2p-primscrn-cur-indfb-move
[449.276782] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[449.371386] [071/132] (571s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[449.473126] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[449.475388] Starting dynamic subtest: pipe-A-default-mode
[450.612362] Dynamic subtest pipe-A-default-mode: SKIP (1.136s)
[450.616393] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.137s)
[450.770568] [072/132] (570s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[450.825640] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[450.828022] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[450.933722] [073/132] (570s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[451.033257] Starting subtest: 4-tiled-16bpp-rotate-270
[451.054998] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.021s)
[451.179533] [074/132] (569s left) kms_universal_plane (cursor-fb-leak)
[451.279093] Starting subtest: cursor-fb-leak
[451.281411] Starting dynamic subtest: pipe-A-eDP-1
[451.609427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s)
[451.622714] Starting dynamic subtest: pipe-B-eDP-1
[452.991740] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s)
[453.003474] Starting dynamic subtest: pipe-C-eDP-1
[454.309627] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s)
[454.322767] Starting dynamic subtest: pipe-D-eDP-1
[455.637451] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.326s)
[455.639921] Subtest cursor-fb-leak: SUCCESS (4.360s)
[456.815965] [075/132] (564s left) kms_rmfb (rmfb-ioctl)
[456.913154] Starting subtest: rmfb-ioctl
[456.915119] Starting dynamic subtest: pipe-A-eDP-1
[457.017811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[457.030139] Starting dynamic subtest: pipe-B-eDP-1
[458.183047] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.163s)
[458.195762] Starting dynamic subtest: pipe-C-eDP-1
[459.422030] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[459.432582] Starting dynamic subtest: pipe-D-eDP-1
[460.637239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s)
[460.639601] Subtest rmfb-ioctl: SUCCESS (3.726s)
[461.877179] [076/132] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[461.985837] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[470.757756] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.771s)
[470.884234] [077/132] (550s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[470.992667] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[471.005051] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s)
[471.093089] [078/132] (550s left) gem_vm_create (invalid-destroy)
[471.140242] Starting subtest: invalid-destroy
[471.145227] Subtest invalid-destroy: SUCCESS (0.002s)
[471.246985] [079/132] (550s left) kms_psr (fbc-pr-primary-render)
[471.333081] Starting subtest: fbc-pr-primary-render
[471.337040] Subtest fbc-pr-primary-render: SKIP (0.000s)
[471.410321] [080/132] (550s left) i915_hangman (engine-error-state-capture)
[471.462531] Starting subtest: engine-error-state-capture
[471.465040] Starting dynamic subtest: rcs0
[474.841778] Dynamic subtest rcs0: SUCCESS (3.380s)
[474.854691] Starting dynamic subtest: bcs0
[480.857105] Dynamic subtest bcs0: SUCCESS (6.011s)
[480.870657] Starting dynamic subtest: vcs0
[486.874264] Dynamic subtest vcs0: SUCCESS (6.013s)
[486.887033] Starting dynamic subtest: vcs1
[492.827353] Dynamic subtest vcs1: SUCCESS (5.949s)
[492.841753] Starting dynamic subtest: vecs0
[498.778566] Dynamic subtest vecs0: SUCCESS (5.948s)
[498.791092] Starting dynamic subtest: ccs0
[503.835140] Dynamic subtest ccs0: SUCCESS (5.052s)
[503.837897] Subtest engine-error-state-capture: SUCCESS (32.370s)
[503.981624] [081/132] (517s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[504.094602] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[504.098711] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[504.199839] [082/132] (517s left) kms_plane_scaling (planes-upscale-20x20)
[504.286015] Starting subtest: planes-upscale-20x20
[504.288196] Starting dynamic subtest: pipe-A
[504.346596] Dynamic subtest pipe-A: SUCCESS (0.062s)
[504.358484] Starting dynamic subtest: pipe-B
[505.488137] Dynamic subtest pipe-B: SUCCESS (1.140s)
[505.498325] Starting dynamic subtest: pipe-C
[506.596494] Dynamic subtest pipe-C: SUCCESS (1.107s)
[506.606539] Starting dynamic subtest: pipe-D
[507.736532] Dynamic subtest pipe-D: SUCCESS (1.139s)
[507.738877] Subtest planes-upscale-20x20: SUCCESS (3.453s)
[508.890808] [083/132] (512s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[509.022229] Starting subtest: cursorA-vs-flipB-toggle
[509.027664] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[509.163334] [084/132] (512s left) gem_exec_reloc (basic-wc-cpu)
[509.221914] Subtest basic-wc-cpu: SKIP (0.000s)
[509.292221] [085/132] (512s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[509.382206] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[509.386586] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[509.469538] [086/132] (512s left) i915_suspend (fence-restore-untiled)
[509.517692] Starting subtest: fence-restore-untiled
[509.522011] Subtest fence-restore-untiled: SKIP (0.000s)
[509.631127] [087/132] (512s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[509.677904] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[509.680188] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[509.794039] [088/132] (511s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[509.887812] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[509.891216] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[509.982084] [089/132] (511s left) kms_pm_lpsp (screens-disabled)
[511.085595] Starting subtest: screens-disabled
[511.090098] Subtest screens-disabled: SKIP (0.000s)
[511.158094] [090/132] (510s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[511.257311] Starting subtest: plane-lut1d-post-ctm3x4
[511.424367] Starting dynamic subtest: pipe-A-plane-0
[511.613317] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[511.624466] Starting dynamic subtest: pipe-A-plane-1
[511.769234] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[511.780019] Starting dynamic subtest: pipe-A-plane-2
[511.925332] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[513.130662] Starting dynamic subtest: pipe-B-plane-0
[513.319995] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[513.331639] Starting dynamic subtest: pipe-B-plane-1
[513.507352] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[513.517745] Starting dynamic subtest: pipe-B-plane-2
[513.673348] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[514.938976] Starting dynamic subtest: pipe-C-plane-0
[515.096140] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[515.107411] Starting dynamic subtest: pipe-C-plane-1
[515.264704] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[515.275693] Starting dynamic subtest: pipe-C-plane-2
[515.429460] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[516.689169] Starting dynamic subtest: pipe-D-plane-0
[516.845605] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[516.856313] Starting dynamic subtest: pipe-D-plane-1
[517.012744] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[517.024537] Starting dynamic subtest: pipe-D-plane-2
[517.179008] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[517.465844] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.211s)
[518.325889] [091/132] (503s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[518.422244] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[518.426376] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[518.508916] [092/132] (503s left) gem_mmap_wc (bad-offset)
[518.561562] Subtest bad-offset: SKIP (0.000s)
[518.618005] [093/132] (503s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[518.719628] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[518.723640] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[518.793287] [094/132] (503s left) gem_eio (unwedge-stress)
[518.997457] Starting subtest: unwedge-stress
[518.999786] Starting dynamic subtest: render
[523.282345] Dynamic subtest render: SUCCESS (4.281s)
[523.300468] Starting dynamic subtest: bsd1
[541.348746] Dynamic subtest bsd1: SUCCESS (18.065s)
[541.367438] Starting dynamic subtest: bsd2
[559.362956] Dynamic subtest bsd2: SUCCESS (18.015s)
[559.380593] Starting dynamic subtest: blt
[559.384619] Dynamic subtest blt: SKIP (0.000s)
[559.394528] Starting dynamic subtest: vebox
[577.333508] Dynamic subtest vebox: SUCCESS (17.971s)
[577.336240] Subtest unwedge-stress: SUCCESS (58.337s)
[578.926600] [095/132] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[579.026272] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[579.030217] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[579.125090] [096/132] (442s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[579.222555] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[579.227262] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[579.338615] [097/132] (442s left) gem_exec_capture (pi)
[579.396873] Starting subtest: pi
[579.399202] Starting dynamic subtest: rcs0
[583.831305] Dynamic subtest rcs0: SUCCESS (4.435s)
[583.842097] Starting dynamic subtest: bcs0
[587.950638] Dynamic subtest bcs0: SUCCESS (4.119s)
[587.963734] Starting dynamic subtest: vcs0
[592.004640] Dynamic subtest vcs0: SUCCESS (4.052s)
[592.016599] Starting dynamic subtest: vcs1
[596.152451] Dynamic subtest vcs1: SUCCESS (4.147s)
[596.165885] Starting dynamic subtest: vecs0
[600.263409] Dynamic subtest vecs0: SUCCESS (4.110s)
[600.275752] Starting dynamic subtest: ccs0
[604.342462] Dynamic subtest ccs0: SUCCESS (4.079s)
[604.344856] Subtest pi: SUCCESS (24.949s)
[604.443393] [098/132] (417s left) gem_eio (wait-wedge-1us)
[604.706366] Starting subtest: wait-wedge-1us
[605.954804] Subtest wait-wedge-1us: SUCCESS (1.248s)
[606.084825] [099/132] (416s left) gem_ctx_param (invalid-set-no-zeromap)
[606.135977] Starting subtest: invalid-set-no-zeromap
[606.138377] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[606.214998] [100/132] (416s left) gem_workarounds (suspend-resume-fd)
[606.297470] Starting subtest: suspend-resume-fd
[622.798332] Subtest suspend-resume-fd: SUCCESS (1.165s)
[622.938783] [101/132] (399s left) gem_lmem_swapping (verify-ccs)
[622.996497] Subtest verify-ccs: SKIP (0.000s)
[623.044679] [102/132] (399s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[623.098930] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[623.208015] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[623.313847] [103/132] (399s left) gen9_exec_parse (cmd-crossing-page)
[623.375210] Subtest cmd-crossing-page: SKIP (0.000s)
[623.435304] [104/132] (399s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[623.529870] Starting subtest: psr-indfb-scaledprimary
[629.259237] Subtest psr-indfb-scaledprimary: SUCCESS (5.837s)
[629.386410] [105/132] (393s left) gem_ctx_bad_destroy (invalid-ctx)
[629.449149] Starting subtest: invalid-ctx
[629.451879] Subtest invalid-ctx: SUCCESS (0.000s)
[629.526695] [106/132] (393s left) gem_mmap_gtt (basic-write-read-distinct)
[629.579403] Subtest basic-write-read-distinct: SKIP (0.000s)
[629.645514] [107/132] (392s left) gem_spin_batch (resubmit-all)
[629.707791] Starting subtest: resubmit-all
[629.710538] Starting dynamic subtest: rcs0
[629.720550] Dynamic subtest rcs0: SUCCESS (0.013s)
[629.733406] Starting dynamic subtest: bcs0
[629.736300] Dynamic subtest bcs0: SUCCESS (0.002s)
[629.747060] Starting dynamic subtest: vcs0
[629.749443] Dynamic subtest vcs0: SUCCESS (0.002s)
[629.760516] Starting dynamic subtest: vcs1
[629.763302] Dynamic subtest vcs1: SUCCESS (0.002s)
[629.774604] Starting dynamic subtest: vecs0
[629.777308] Dynamic subtest vecs0: SUCCESS (0.002s)
[629.788491] Starting dynamic subtest: ccs0
[629.791398] Dynamic subtest ccs0: SUCCESS (0.002s)
[629.794215] Subtest resubmit-all: SUCCESS (0.028s)
[631.247767] [108/132] (391s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[631.335238] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[631.340043] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[631.408415] [109/132] (391s left) syncobj_wait (invalid-wait-bad-flags)
[631.472562] Starting subtest: invalid-wait-bad-flags
[631.475298] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[631.586374] [110/132] (391s left) perf_pmu (module-unload)